CraftBukkit Version: git-Bukkit-1.7.2-R0.3-b3020jnks (MC: 1.7.2)
Active Plugins: WorldEdit: 5.5.8, Craftconomy3: 3.1.5 jenkins-Craftconomy3-2076, DwarfCraft: 1.9.3,
Vault: 1.2.31-b411, PermissionsEx: 1.20.4, Multiverse-Core: 2.5-b678, WorldGuard: 5.9,
Essentials: Pre2.13.1.6, dynmap: 1.9.2-940, Citizens: 2.0.11-SNAPSHOT (build 1053),
MagicSpells: 3.1, EssentialsProtect: Pre2.13.1.6, Denizen: 0.9.4-SNAPSHOT (build 1434),
EssentialsSpawn: Pre2.13.1.6, Multiverse-Portals: 2.5-b699, Sentry: 1.8.0,
EssentialsChat: Pre2.13.1.6, EssentialsAntiBuild: Pre2.13.1.6, Quester: 0.6.3.6,
dtlTraders: 3.0.9-snapshot
Loaded Worlds: Azeroth, Azeroth_nether, Azeroth_the_end, dev_world
Online Players: NLS667(NLS667)
00:18:56 [INFO] +- Parsing PROXIMITY trigger: test/NLS667 ---------+
00:18:56 [INFO] Starting TimedQueue 'DEZIEZDZZE'...
00:18:56 [INFO] +- Executing dCommand: LOOKCLOSE/NLS667 ---------+
00:18:56 [INFO] Filled tag <npc> with 'n@27'.
00:18:56 [INFO] +> Executing 'LOOKCLOSE': npc='n@27' toggle='true'
00:18:57 [INFO] +- Executing dCommand: RUN/NLS667 ---------+
00:18:57 [INFO] +> Executing 'RUN': script='GREETINGS(TASK)'
00:18:57 [INFO] Starting TimedQueue 'DENENEZEDZ'...
00:18:57 [INFO] +- Executing dCommand: CHAT/NLS667 ---------+
00:18:57 [INFO] Filled tag <player.name> with 'NLS667'.
00:18:57 [INFO] Filled tag <player.name> with 'NLS667'.
00:18:57 [INFO] +> Executing 'CHAT': talkers='li@n@27'
targets='li@p@NLS667' message='Hello there NLS667!'
00:18:57 [INFO] Completing queue 'DENENEZEDZ'.
00:18:57 [INFO] Completing queue 'DEZIEZDZZE'.
00:18:57 [INFO] Completing queue 'DENENEZEDZ'.
00:19:00 [INFO] +- Getting interact script: test/NLS667 ---------+
00:19:00 [INFO] OKAY! '10 LUMBERJACK LIFE' meets requirements.
00:19:00 [INFO]
00:19:00 [INFO] OKAY! Highest scoring script is LUMBERJACK LIFE.
00:19:00 [INFO] +---------------------+
00:19:00 [INFO] +- Parsing CLICK trigger: test/NLS667 ---------+
00:19:00 [INFO] Starting TimedQueue 'NNEEZZIEEE'...
00:19:00 [INFO] +- Executing dCommand: RUN/NLS667 ---------+
00:19:00 [INFO] +> Executing 'RUN': script='STARTWORKING(TASK)'
00:19:00 [INFO] Starting TimedQueue 'NEENDENNEI'...
00:19:00 [INFO] +- Executing dCommand: CHAT/NLS667 ---------+
00:19:00 [INFO] Filled tag <player.name> with 'NLS667'.
00:19:00 [INFO] +> Executing 'CHAT': talkers='li@n@27'
targets='li@p@NLS667' message='OK. Im starting my work.'
00:19:00 [INFO] Completing queue 'NNEEZZIEEE'.
00:19:00 [INFO] +- Executing dCommand: RUN/NLS667 ---------+
00:19:00 [INFO] +> Executing 'RUN': script='LOOKFORTREES(TASK)'
00:19:00 [INFO] Starting TimedQueue 'NNNNNENDEE'...
00:19:00 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:00 [INFO] +> Executing 'FLAG': flag_name='FOUND_TREES'
Action/Value='DELETE(false)' npc='n@27'
00:19:00 [INFO] Completing queue 'NEENDENNEI'.
00:19:00 [INFO] Completing queue 'NNEEZZIEEE'.
00:19:01 [INFO] +- Executing dCommand: FOREACH/NLS667 ---------+
00:19:01 [INFO] Filled tag <cons:logs> with 'oak_log|birch_log'.
00:19:01 [INFO] Filled tag <cons:initialRange> with '10'.
00:19:01 [INFO] Filled tag
<npc.location.find.blocks[oak_log|birch_log].within[10].as_list>
with
'li@l@250.5,4.0,-1618.5,dev_world|l@250.5,5.0,-1618.5,dev_world|l@250.5,6.0,-1618.5,dev_world|l@250.5,7.0,-1618.5,dev_world|l@250.5,8.0,-1618.5,dev_world|l@242.5,4.0,-1617.5,dev_world|l@242.5,5.0,-1617.5,dev_world|l@242.5,6.0,-1617.5,dev_world|l@242.5,7.0,-1617.5,dev_world|l@242.5,8.0,-1617.5,dev_world|l@248.5,4.0,-1624.5,dev_world|l@242.5,9.0,-1617.5,dev_world|l@248.5,5.0,-1624.5,dev_world|l@248.5,6.0,-1624.5,dev_world|l@248....
* snip! *
00:19:01 [INFO] +> Executing 'FOREACH':
list='li@l@250.5,4.0,-1618.5,dev_world|l@250.5,5.0,-1618.5,dev_world|l@250.5,6.0,-1618.5,dev_world|l@250.5,7.0,-1618.5,dev_world|l@250.5,8.0,-1618.5,dev_world|l@242.5,4.0,-1617.5,dev_world|l@242.5,5.0,-1617.5,dev_world|l@242.5,6.0,-1617.5,dev_world|l@242.5,7.0,-1617.5,dev_world|l@242.5,8.0,-1617.5,dev_world|l@248.5,4.0,-1624.5,dev_world|l@242.5,9.0,-1617.5,dev_world|l@248.5,5.0,-1624.5,dev_world|l@248.5,6.0,-1624.5,dev_world|l@248.5,7.0,-1624.5,dev_world|l@248.5,8.0,-1624.5,dev_world|l@248.5,9.0,-162...
* snip! *
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@250.5,4.0,-1618.5,dev_world]>
with 'true'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:01 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:01 [INFO] +> Executing 'FLAG': flag_name='FOUND_TREES'
Action/Value='SPLIT(l@250.5,4.0,-1618.5,dev_world)'
npc='n@27'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@250.5,5.0,-1618.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@250.5,6.0,-1618.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@250.5,7.0,-1618.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@250.5,8.0,-1618.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,4.0,-1617.5,dev_world]>
with 'true'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:01 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:01 [INFO] +> Executing 'FLAG': flag_name='FOUND_TREES'
Action/Value='SPLIT(l@242.5,4.0,-1617.5,dev_world)'
npc='n@27'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,5.0,-1617.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,6.0,-1617.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,7.0,-1617.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,8.0,-1617.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,4.0,-1624.5,dev_world]>
with 'true'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:01 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:01 [INFO] +> Executing 'FLAG': flag_name='FOUND_TREES'
Action/Value='SPLIT(l@248.5,4.0,-1624.5,dev_world)'
npc='n@27'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,9.0,-1617.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,5.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,6.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,7.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,8.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,9.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@248.5,10.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,4.0,-1624.5,dev_world]>
with 'true'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:01 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:01 [INFO] +> Executing 'FLAG': flag_name='FOUND_TREES'
Action/Value='SPLIT(l@242.5,4.0,-1624.5,dev_world)'
npc='n@27'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,5.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,6.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,7.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag
<proc[isTreeHump].context[l@242.5,8.0,-1624.5,dev_world]>
with 'false'.
00:19:01 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:01 [INFO] +- Executing dCommand: IF/NLS667 ---------+
00:19:01 [INFO] Filled tag <npc.flag[found_trees].size.as_int> with '4'.
00:19:01 [INFO] Comparable 1: Comparable='Integer(4)', Operator='EQUALS',
ComparedTo='Integer(0)' --> OUTCOME='false'
00:19:02 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:02 [INFO] +> Executing 'FLAG': flag_name='CURRENT_TREE'
Action/Value='SET_VALUE(1)' npc='n@27'
00:19:02 [INFO] +- Executing dCommand: LOOKCLOSE/NLS667 ---------+
00:19:02 [INFO] Filled tag <npc> with 'n@27'.
00:19:02 [INFO] +> Executing 'LOOKCLOSE': npc='n@27' toggle='false'
00:19:02 [INFO] +- Executing dCommand: WALKTO/NLS667 ---------+
00:19:02 [INFO] Filled tag <npc> with 'n@27'.
00:19:02 [INFO] Filled tag <npc.flag[current_tree].as_int> with '1'.
00:19:02 [INFO] Filled tag <npc.flag[found_trees].get[1]> with
'l@250.5,4.0,-1618.5,dev_world'.
00:19:02 [INFO] +> Executing 'WALKTO':
location='l@250.5,4.0,-1618.5,dev_world' npcs='[test/27]'
00:19:02 [INFO] +- Executing dCommand: FLAG/NLS667 ---------+
00:19:02 [INFO] +> Executing 'FLAG': flag_name='READY_TO_CUT'
Action/Value='SET_VALUE(true)' npc='n@27'
00:19:02 [INFO] +- Executing dCommand: QUEUE/NLS667 ---------+
00:19:02 [INFO] +> Executing 'QUEUE': Queue='NNNNNENDEE' Action='CLEAR'
00:19:02 [INFO] Completing queue 'NNNNNENDEE'.
00:19:02 [INFO] +> Executing 'Action': Type='On complete navigation'
NPC='test/27' Container='LUMBERJACK(ASSIGNMENT)'
00:19:02 [INFO] +- Building action 'On COMPLETE NAVIGATION' for test/27
---------+
00:19:02 [INFO] Starting InstantQueue 'DDEDIIENDZ'...
00:19:02 [INFO] +- Executing dCommand: IF/test ---------+
00:19:02 [INFO] Filled tag <npc.flag[ready_to_cut]> with 'true'.
00:19:02 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:02 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:02 [INFO] +> Executing 'RUN': script='DEFINETREE(TASK)'
00:19:02 [INFO] Starting TimedQueue 'EEIEDDEIDZ'...
00:19:02 [INFO] +- Executing dCommand: LOOK/test ---------+
00:19:02 [INFO] Filled tag <npc> with 'n@27'.
00:19:02 [INFO] Filled tag <npc.flag[current_tree].as_int> with '1'.
00:19:02 [INFO] Filled tag <npc.flag[found_trees].get[1]> with
'l@250.5,4.0,-1618.5,dev_world'.
00:19:02 [INFO] +> Executing 'LOOK':
location='l@250.5,4.0,-1618.5,dev_world'
entities='[n@27]'
00:19:02 [INFO] Completing queue 'DDEDIIENDZ'.
00:19:03 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:03 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='DELETE(false)' npc='n@27'
00:19:03 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:03 [INFO] Filled tag <npc.flag[current_tree]> with '1'.
00:19:03 [INFO] Filled tag <npc.flag[found_trees].get[1]> with
'l@250.5,4.0,-1618.5,dev_world'.
00:19:03 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,4.0,-1618.5,dev_world)'
npc='n@27'
00:19:04 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:04 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='SET_VALUE(1)' npc='n@27'
00:19:04 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:04 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:04 [INFO] Starting TimedQueue 'NENZEEIIEE'...
00:19:04 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:04 [INFO] Filled tag <npc.flag[current_elem].as_int> with '1'.
00:19:04 [INFO] Filled tag <npc.flag[tree_elems].get[1]> with
'l@250.5,4.0,-1618.5,dev_world'.
00:19:04 [INFO] +> Executing 'DEFINE': queue='NENZEEIIEE'
definition='currentblock'
value='l@250.5,4.0,-1618.5,dev_world'
00:19:04 [INFO] Completing queue 'EEIEDDEIDZ'.
00:19:05 [INFO] +- Executing dCommand: IF/test ---------+
00:19:05 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,4.0,-1618.5,dev_world]>
with 'true'.
00:19:05 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:05 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:05 [INFO] Filled tag <npc> with 'n@27'.
00:19:05 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:05 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:05 [INFO] Filled tag <l@250.5,4.0,-1618.5,dev_world.above> with
'l@250.5,5.0,-1618.5,dev_world'.
00:19:05 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,5.0,-1618.5,dev_world)'
npc='n@27'
00:19:05 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:05 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:05 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:05 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:05 [INFO] Starting TimedQueue 'DNDEEZZEID'...
00:19:05 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:05 [INFO] Filled tag <npc.flag[current_elem].as_int> with '2'.
00:19:05 [INFO] Filled tag <npc.flag[tree_elems].get[2]> with
'l@250.5,5.0,-1618.5,dev_world'.
00:19:05 [INFO] +> Executing 'DEFINE': queue='DNDEEZZEID'
definition='currentblock'
value='l@250.5,5.0,-1618.5,dev_world'
00:19:05 [INFO] Completing queue 'NENZEEIIEE'.
00:19:06 [INFO] +- Executing dCommand: IF/test ---------+
00:19:06 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,5.0,-1618.5,dev_world]>
with 'true'.
00:19:06 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:06 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:06 [INFO] Filled tag <npc> with 'n@27'.
00:19:06 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:06 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:06 [INFO] Filled tag <l@250.5,5.0,-1618.5,dev_world.above> with
'l@250.5,6.0,-1618.5,dev_world'.
00:19:06 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,6.0,-1618.5,dev_world)'
npc='n@27'
00:19:06 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:06 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:06 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:06 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:06 [INFO] Starting TimedQueue 'INIEDINEZE'...
00:19:06 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:06 [INFO] Filled tag <npc.flag[current_elem].as_int> with '3'.
00:19:06 [INFO] Filled tag <npc.flag[tree_elems].get[3]> with
'l@250.5,6.0,-1618.5,dev_world'.
00:19:06 [INFO] +> Executing 'DEFINE': queue='INIEDINEZE'
definition='currentblock'
value='l@250.5,6.0,-1618.5,dev_world'
00:19:06 [INFO] Completing queue 'DNDEEZZEID'.
00:19:07 [INFO] +- Executing dCommand: IF/test ---------+
00:19:07 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,6.0,-1618.5,dev_world]>
with 'true'.
00:19:07 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:07 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:07 [INFO] Filled tag <npc> with 'n@27'.
00:19:07 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:07 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:07 [INFO] Filled tag <l@250.5,6.0,-1618.5,dev_world.above> with
'l@250.5,7.0,-1618.5,dev_world'.
00:19:07 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,7.0,-1618.5,dev_world)'
npc='n@27'
00:19:07 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:07 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:07 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:07 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:07 [INFO] Starting TimedQueue 'NEZEDIEINN'...
00:19:07 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:07 [INFO] Filled tag <npc.flag[current_elem].as_int> with '4'.
00:19:07 [INFO] Filled tag <npc.flag[tree_elems].get[4]> with
'l@250.5,7.0,-1618.5,dev_world'.
00:19:07 [INFO] +> Executing 'DEFINE': queue='NEZEDIEINN'
definition='currentblock'
value='l@250.5,7.0,-1618.5,dev_world'
00:19:07 [INFO] Completing queue 'INIEDINEZE'.
00:19:08 [INFO] +- Executing dCommand: IF/test ---------+
00:19:08 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,7.0,-1618.5,dev_world]>
with 'true'.
00:19:08 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:08 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:08 [INFO] Filled tag <npc> with 'n@27'.
00:19:08 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:08 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:08 [INFO] Filled tag <l@250.5,7.0,-1618.5,dev_world.above> with
'l@250.5,8.0,-1618.5,dev_world'.
00:19:08 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,8.0,-1618.5,dev_world)'
npc='n@27'
00:19:08 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:08 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:08 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:08 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:08 [INFO] Starting TimedQueue 'NNDIDDZDEE'...
00:19:08 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:08 [INFO] Filled tag <npc.flag[current_elem].as_int> with '5'.
00:19:08 [INFO] Filled tag <npc.flag[tree_elems].get[5]> with
'l@250.5,8.0,-1618.5,dev_world'.
00:19:08 [INFO] +> Executing 'DEFINE': queue='NNDIDDZDEE'
definition='currentblock'
value='l@250.5,8.0,-1618.5,dev_world'
00:19:08 [INFO] Completing queue 'NEZEDIEINN'.
00:19:09 [INFO] +- Executing dCommand: IF/test ---------+
00:19:09 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,8.0,-1618.5,dev_world]>
with 'false'.
00:19:09 [INFO] Comparable 1: Comparable='Boolean(false)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='false'
00:19:09 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:09 [INFO] +> Executing 'RUN': script='LOOKFORLEAVES(TASK)'
00:19:09 [INFO] Starting TimedQueue 'IZIEZNENIN'...
00:19:09 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:09 [INFO] Filled tag <npc.flag[tree_elems].size.as_int> with '5'.
00:19:09 [INFO] Filled tag <npc.flag[tree_elems].get[5]> with
'l@250.5,8.0,-1618.5,dev_world'.
00:19:09 [INFO] +> Executing 'DEFINE': queue='IZIEZNENIN'
definition='topblock'
value='l@250.5,8.0,-1618.5,dev_world'
00:19:09 [INFO] Completing queue 'NNDIDDZDEE'.
00:19:10 [INFO] +- Executing dCommand: FOREACH/test ---------+
00:19:10 [INFO] Filled tag <cons:leaves> with 'leaves|birch_leaves'.
00:19:10 [INFO] Filled tag
<l@250.5,8.0,-1618.5,dev_world.find.blocks[leaves|birch_leaves].within[3].as_list>
with
'li@l@249.5,8.0,-1618.5,dev_world|l@250.5,8.0,-1619.5,dev_world|l@250.5,8.0,-1617.5,dev_world|l@250.5,9.0,-1618.5,dev_world|l@251.5,8.0,-1618.5,dev_world|l@249.5,7.0,-1618.5,dev_world|l@249.5,8.0,-1619.5,dev_world|l@249.5,9.0,-1618.5,dev_world|l@250.5,7.0,-1619.5,dev_world|l@250.5,7.0,-1617.5,dev_world|l@250.5,9.0,-1619.5,dev_world|l@250.5,9.0,-1617.5,dev_world|l@251.5,7.0,-1618.5,dev_world|l@251.5,9.0,-1618....
* snip! *
00:19:10 [INFO] +> Executing 'FOREACH':
list='li@l@249.5,8.0,-1618.5,dev_world|l@250.5,8.0,-1619.5,dev_world|l@250.5,8.0,-1617.5,dev_world|l@250.5,9.0,-1618.5,dev_world|l@251.5,8.0,-1618.5,dev_world|l@249.5,7.0,-1618.5,dev_world|l@249.5,8.0,-1619.5,dev_world|l@249.5,9.0,-1618.5,dev_world|l@250.5,7.0,-1619.5,dev_world|l@250.5,7.0,-1617.5,dev_world|l@250.5,9.0,-1619.5,dev_world|l@250.5,9.0,-1617.5,dev_world|l@251.5,7.0,-1618.5,dev_world|l@251.5,9.0,-1618.5,dev_world|l@249.5,7.0,-1619.5,dev_world|l@249.5,7.0,-1617.5,dev_world|l@251.5,7.0,-161...
* snip! *
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,8.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,8.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,8.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,9.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,8.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,7.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,8.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,9.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,7.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,7.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,9.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,9.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,7.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,9.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,7.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,7.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,7.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,7.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@248.5,7.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,6.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,6.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,6.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,7.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,7.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,6.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,7.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@248.5,7.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@248.5,7.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,6.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,6.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,7.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,7.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,6.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,6.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,7.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,7.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,7.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,7.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@248.5,6.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,6.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,6.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,6.0,-1618.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@248.5,6.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@248.5,6.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,6.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@249.5,6.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,6.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@251.5,6.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,6.0,-1619.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,6.0,-1617.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,6.0,-1620.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:10 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@252.5,6.0,-1616.5,dev_world)'
npc='n@27'
00:19:10 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:10 [INFO] +> Executing 'RUN': script='CUTTREE(TASK)'
00:19:10 [INFO] Starting TimedQueue 'DEENINNIEI'...
00:19:10 [INFO] +- Executing dCommand: FOREACH/test ---------+
00:19:10 [INFO] Filled tag <npc.flag[tree_elems].as_list> with
'li@l@250.5,4.0,-1618.5,dev_world|l@250.5,5.0,-1618.5,dev_world|l@250.5,6.0,-1618.5,dev_world|l@250.5,7.0,-1618.5,dev_world|l@250.5,8.0,-1618.5,dev_world|l@249.5,8.0,-1618.5,dev_world|l@250.5,8.0,-1619.5,dev_world|l@250.5,8.0,-1617.5,dev_world|l@250.5,9.0,-1618.5,dev_world|l@251.5,8.0,-1618.5,dev_world|l@249.5,7.0,-1618.5,dev_world|l@249.5,8.0,-1619.5,dev_world|l@249.5,9.0,-1618.5,dev_world|l@250.5,7.0,-1619.5,dev_world|l@250.5,7.0,-1617.5,dev_world|l@250.5,9....
* snip! *
00:19:10 [INFO] +> Executing 'FOREACH':
list='li@l@250.5,4.0,-1618.5,dev_world|l@250.5,5.0,-1618.5,dev_world|l@250.5,6.0,-1618.5,dev_world|l@250.5,7.0,-1618.5,dev_world|l@250.5,8.0,-1618.5,dev_world|l@249.5,8.0,-1618.5,dev_world|l@250.5,8.0,-1619.5,dev_world|l@250.5,8.0,-1617.5,dev_world|l@250.5,9.0,-1618.5,dev_world|l@251.5,8.0,-1618.5,dev_world|l@249.5,7.0,-1618.5,dev_world|l@249.5,8.0,-1619.5,dev_world|l@249.5,9.0,-1618.5,dev_world|l@250.5,7.0,-1619.5,dev_world|l@250.5,7.0,-1617.5,dev_world|l@250.5,9.0,-1619.5,dev_world|l@250.5,9.0,-161...
* snip! *
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,4.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,5.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,6.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,7.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,8.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,8.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,8.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,8.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,9.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,8.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,7.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,8.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,9.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,7.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,7.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,9.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,9.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,7.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,9.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,7.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,7.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,7.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,7.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@248.5,7.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,6.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,6.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,6.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,7.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,7.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,6.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,7.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@248.5,7.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@248.5,7.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,6.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,6.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,7.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,7.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,6.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,6.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,7.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,7.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,7.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,7.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@248.5,6.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,6.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@250.5,6.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,6.0,-1618.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@248.5,6.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@248.5,6.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,6.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@249.5,6.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,6.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@251.5,6.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,6.0,-1619.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,6.0,-1617.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,6.0,-1620.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] +- Executing dCommand: MODIFYBLOCK/test ---------+
00:19:10 [INFO] +> Executing 'MODIFYBLOCK':
locations='[l@252.5,6.0,-1616.5,dev_world]'
material='m@air' radius='0' height='0' depth='0'
00:19:10 [INFO] Completing queue 'IZIEZNENIN'.
00:19:11 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:11 [INFO] +> Executing 'FLAG': flag_name='CURRENT_TREE'
Action/Value='INCREASE(1)' npc='n@27'
00:19:11 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:11 [INFO] +> Executing 'RUN': script='DISPATCH(TASK)'
00:19:11 [INFO] Starting TimedQueue 'DEIEIENNDN'...
00:19:11 [INFO] +- Executing dCommand: IF/test ---------+
00:19:11 [INFO] Filled tag <npc.flag[current_tree].as_int> with '2'.
00:19:11 [INFO] Filled tag <npc.flag[found_trees].size.as_int> with '4'.
00:19:11 [INFO] Comparable 1: Comparable='Integer(2)', Operator='MORE',
ComparedTo='Integer(4)' --> OUTCOME='false'
00:19:11 [INFO] Completing queue 'DEENINNIEI'.
00:19:12 [INFO] +- Executing dCommand: WALKTO/test ---------+
00:19:12 [INFO] Filled tag <npc> with 'n@27'.
00:19:12 [INFO] Filled tag <npc.flag[current_tree].as_int> with '2'.
00:19:12 [INFO] Filled tag <npc.flag[found_trees].get[2]> with
'l@242.5,4.0,-1617.5,dev_world'.
00:19:12 [INFO] +> Executing 'WALKTO':
location='l@242.5,4.0,-1617.5,dev_world' npcs='[test/27]'
00:19:12 [INFO] Completing queue 'DEIEIENNDN'.
00:19:13 [INFO] +> Executing 'Action': Type='On complete navigation'
NPC='test/27' Container='LUMBERJACK(ASSIGNMENT)'
00:19:13 [INFO] +- Building action 'On COMPLETE NAVIGATION' for test/27
---------+
00:19:13 [INFO] Starting InstantQueue 'NEIDENNINZ'...
00:19:13 [INFO] +- Executing dCommand: IF/test ---------+
00:19:13 [INFO] Filled tag <npc.flag[ready_to_cut]> with 'true'.
00:19:13 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:13 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:13 [INFO] +> Executing 'RUN': script='DEFINETREE(TASK)'
00:19:13 [INFO] Starting TimedQueue 'EEIDNINNEZ'...
00:19:13 [INFO] +- Executing dCommand: LOOK/test ---------+
00:19:13 [INFO] Filled tag <npc> with 'n@27'.
00:19:13 [INFO] Filled tag <npc.flag[current_tree].as_int> with '2'.
00:19:13 [INFO] Filled tag <npc.flag[found_trees].get[2]> with
'l@242.5,4.0,-1617.5,dev_world'.
00:19:13 [INFO] +> Executing 'LOOK':
location='l@242.5,4.0,-1617.5,dev_world'
entities='[n@27]'
00:19:13 [INFO] Completing queue 'NEIDENNINZ'.
00:19:14 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:14 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='DELETE(false)' npc='n@27'
00:19:14 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:14 [INFO] Filled tag <npc.flag[current_tree]> with '2.0'.
00:19:14 [INFO] Filled tag <npc.flag[found_trees].get[2.0]> with
'l@250.5,4.0,-1618.5,dev_world'.
00:19:14 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,4.0,-1618.5,dev_world)'
npc='n@27'
00:19:15 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:15 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='SET_VALUE(1)' npc='n@27'
00:19:15 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:15 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:15 [INFO] Starting TimedQueue 'NNDEIIIDZI'...
00:19:15 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:15 [INFO] Filled tag <npc.flag[current_elem].as_int> with '1'.
00:19:15 [INFO] Filled tag <npc.flag[tree_elems].get[1]> with
'l@250.5,4.0,-1618.5,dev_world'.
00:19:15 [INFO] +> Executing 'DEFINE': queue='NNDEIIIDZI'
definition='currentblock'
value='l@250.5,4.0,-1618.5,dev_world'
00:19:15 [INFO] Completing queue 'EEIDNINNEZ'.
00:19:16 [INFO] +- Executing dCommand: IF/test ---------+
00:19:16 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,4.0,-1618.5,dev_world]>
with 'true'.
00:19:16 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:16 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:16 [INFO] Filled tag <npc> with 'n@27'.
00:19:16 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:16 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:16 [INFO] Filled tag <l@250.5,4.0,-1618.5,dev_world.above> with
'l@250.5,5.0,-1618.5,dev_world'.
00:19:16 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,5.0,-1618.5,dev_world)'
npc='n@27'
00:19:16 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:16 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:16 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:16 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:16 [INFO] Starting TimedQueue 'NNZNDZZENE'...
00:19:16 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:16 [INFO] Filled tag <npc.flag[current_elem].as_int> with '2'.
00:19:16 [INFO] Filled tag <npc.flag[tree_elems].get[2]> with
'l@250.5,5.0,-1618.5,dev_world'.
00:19:16 [INFO] +> Executing 'DEFINE': queue='NNZNDZZENE'
definition='currentblock'
value='l@250.5,5.0,-1618.5,dev_world'
00:19:16 [INFO] Completing queue 'NNDEIIIDZI'.
00:19:17 [INFO] +- Executing dCommand: IF/test ---------+
00:19:17 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,5.0,-1618.5,dev_world]>
with 'true'.
00:19:17 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:17 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:17 [INFO] Filled tag <npc> with 'n@27'.
00:19:17 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:17 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:17 [INFO] Filled tag <l@250.5,5.0,-1618.5,dev_world.above> with
'l@250.5,6.0,-1618.5,dev_world'.
00:19:17 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,6.0,-1618.5,dev_world)'
npc='n@27'
00:19:17 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:17 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:17 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:17 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:17 [INFO] Starting TimedQueue 'NNZDNEDNIN'...
00:19:17 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:17 [INFO] Filled tag <npc.flag[current_elem].as_int> with '3'.
00:19:17 [INFO] Filled tag <npc.flag[tree_elems].get[3]> with
'l@250.5,6.0,-1618.5,dev_world'.
00:19:17 [INFO] +> Executing 'DEFINE': queue='NNZDNEDNIN'
definition='currentblock'
value='l@250.5,6.0,-1618.5,dev_world'
00:19:17 [INFO] Completing queue 'NNZNDZZENE'.
00:19:18 [INFO] +- Executing dCommand: IF/test ---------+
00:19:18 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,6.0,-1618.5,dev_world]>
with 'true'.
00:19:18 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:18 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:18 [INFO] Filled tag <npc> with 'n@27'.
00:19:18 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:18 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:18 [INFO] Filled tag <l@250.5,6.0,-1618.5,dev_world.above> with
'l@250.5,7.0,-1618.5,dev_world'.
00:19:18 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,7.0,-1618.5,dev_world)'
npc='n@27'
00:19:18 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:18 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:18 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:18 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:18 [INFO] Starting TimedQueue 'EEDIENZEEI'...
00:19:18 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:18 [INFO] Filled tag <npc.flag[current_elem].as_int> with '4'.
00:19:18 [INFO] Filled tag <npc.flag[tree_elems].get[4]> with
'l@250.5,7.0,-1618.5,dev_world'.
00:19:18 [INFO] +> Executing 'DEFINE': queue='EEDIENZEEI'
definition='currentblock'
value='l@250.5,7.0,-1618.5,dev_world'
00:19:18 [INFO] Completing queue 'NNZDNEDNIN'.
00:19:19 [INFO] +- Executing dCommand: IF/test ---------+
00:19:19 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,7.0,-1618.5,dev_world]>
with 'true'.
00:19:19 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:19 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:19 [INFO] Filled tag <npc> with 'n@27'.
00:19:19 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:19 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:19 [INFO] Filled tag <l@250.5,7.0,-1618.5,dev_world.above> with
'l@250.5,8.0,-1618.5,dev_world'.
00:19:19 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,8.0,-1618.5,dev_world)'
npc='n@27'
00:19:19 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:19 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:19 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:19 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:19 [INFO] Starting TimedQueue 'ENNINDZDEE'...
00:19:19 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:19 [INFO] Filled tag <npc.flag[current_elem].as_int> with '5'.
00:19:19 [INFO] Filled tag <npc.flag[tree_elems].get[5]> with
'l@250.5,8.0,-1618.5,dev_world'.
00:19:19 [INFO] +> Executing 'DEFINE': queue='ENNINDZDEE'
definition='currentblock'
value='l@250.5,8.0,-1618.5,dev_world'
00:19:19 [INFO] Completing queue 'EEDIENZEEI'.
00:19:20 [INFO] +- Executing dCommand: IF/test ---------+
00:19:20 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,8.0,-1618.5,dev_world]>
with 'true'.
00:19:20 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:20 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:20 [INFO] Filled tag <npc> with 'n@27'.
00:19:20 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:20 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:20 [INFO] Filled tag <l@250.5,8.0,-1618.5,dev_world.above> with
'l@250.5,9.0,-1618.5,dev_world'.
00:19:20 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,9.0,-1618.5,dev_world)'
npc='n@27'
00:19:20 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:20 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:20 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:20 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:20 [INFO] Starting TimedQueue 'NIDNNEDDID'...
00:19:20 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:20 [INFO] Filled tag <npc.flag[current_elem].as_int> with '6'.
00:19:20 [INFO] Filled tag <npc.flag[tree_elems].get[6]> with
'l@250.5,9.0,-1618.5,dev_world'.
00:19:20 [INFO] +> Executing 'DEFINE': queue='NIDNNEDDID'
definition='currentblock'
value='l@250.5,9.0,-1618.5,dev_world'
00:19:20 [INFO] Completing queue 'ENNINDZDEE'.
00:19:21 [INFO] +- Executing dCommand: IF/test ---------+
00:19:21 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,9.0,-1618.5,dev_world]>
with 'true'.
00:19:21 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:21 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:21 [INFO] Filled tag <npc> with 'n@27'.
00:19:21 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:21 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:21 [INFO] Filled tag <l@250.5,9.0,-1618.5,dev_world.above> with
'l@250.5,10.0,-1618.5,dev_world'.
00:19:21 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,10.0,-1618.5,dev_world)'
npc='n@27'
00:19:21 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:21 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:21 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:21 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:21 [INFO] Starting TimedQueue 'IINEEZZIEN'...
00:19:21 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:21 [INFO] Filled tag <npc.flag[current_elem].as_int> with '7'.
00:19:21 [INFO] Filled tag <npc.flag[tree_elems].get[7]> with
'l@250.5,10.0,-1618.5,dev_world'.
00:19:21 [INFO] +> Executing 'DEFINE': queue='IINEEZZIEN'
definition='currentblock'
value='l@250.5,10.0,-1618.5,dev_world'
00:19:21 [INFO] Completing queue 'NIDNNEDDID'.
00:19:22 [INFO] +- Executing dCommand: IF/test ---------+
00:19:22 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,10.0,-1618.5,dev_world]>
with 'true'.
00:19:22 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:22 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:22 [INFO] Filled tag <npc> with 'n@27'.
00:19:22 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:22 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:22 [INFO] Filled tag <l@250.5,10.0,-1618.5,dev_world.above> with
'l@250.5,11.0,-1618.5,dev_world'.
00:19:22 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,11.0,-1618.5,dev_world)'
npc='n@27'
00:19:22 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:22 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:22 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:22 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:22 [INFO] Starting TimedQueue 'EEEDNNIDDE'...
00:19:22 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:22 [INFO] Filled tag <npc.flag[current_elem].as_int> with '8'.
00:19:22 [INFO] Filled tag <npc.flag[tree_elems].get[8]> with
'l@250.5,11.0,-1618.5,dev_world'.
00:19:22 [INFO] +> Executing 'DEFINE': queue='EEEDNNIDDE'
definition='currentblock'
value='l@250.5,11.0,-1618.5,dev_world'
00:19:22 [INFO] Completing queue 'IINEEZZIEN'.
00:19:23 [INFO] +- Executing dCommand: IF/test ---------+
00:19:23 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,11.0,-1618.5,dev_world]>
with 'true'.
00:19:23 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:23 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:23 [INFO] Filled tag <npc> with 'n@27'.
00:19:23 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:23 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:23 [INFO] Filled tag <l@250.5,11.0,-1618.5,dev_world.above> with
'l@250.5,12.0,-1618.5,dev_world'.
00:19:23 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,12.0,-1618.5,dev_world)'
npc='n@27'
00:19:23 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:23 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:23 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:23 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:23 [INFO] Starting TimedQueue 'NNZENZIIED'...
00:19:23 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:23 [INFO] Filled tag <npc.flag[current_elem].as_int> with '9'.
00:19:23 [INFO] Filled tag <npc.flag[tree_elems].get[9]> with
'l@250.5,12.0,-1618.5,dev_world'.
00:19:23 [INFO] +> Executing 'DEFINE': queue='NNZENZIIED'
definition='currentblock'
value='l@250.5,12.0,-1618.5,dev_world'
00:19:23 [INFO] Completing queue 'EEEDNNIDDE'.
00:19:24 [INFO] +- Executing dCommand: IF/test ---------+
00:19:24 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,12.0,-1618.5,dev_world]>
with 'true'.
00:19:24 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:24 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:24 [INFO] Filled tag <npc> with 'n@27'.
00:19:24 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:24 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:24 [INFO] Filled tag <l@250.5,12.0,-1618.5,dev_world.above> with
'l@250.5,13.0,-1618.5,dev_world'.
00:19:24 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,13.0,-1618.5,dev_world)'
npc='n@27'
00:19:24 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:24 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:24 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:24 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:24 [INFO] Starting TimedQueue 'NZNEIZEEEN'...
00:19:24 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:24 [INFO] Filled tag <npc.flag[current_elem].as_int> with '10'.
00:19:24 [INFO] Filled tag <npc.flag[tree_elems].get[10]> with
'l@250.5,13.0,-1618.5,dev_world'.
00:19:24 [INFO] +> Executing 'DEFINE': queue='NZNEIZEEEN'
definition='currentblock'
value='l@250.5,13.0,-1618.5,dev_world'
00:19:24 [INFO] Completing queue 'NNZENZIIED'.
00:19:25 [INFO] +- Executing dCommand: IF/test ---------+
00:19:25 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,13.0,-1618.5,dev_world]>
with 'true'.
00:19:25 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:25 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:25 [INFO] Filled tag <npc> with 'n@27'.
00:19:25 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:25 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:25 [INFO] Filled tag <l@250.5,13.0,-1618.5,dev_world.above> with
'l@250.5,14.0,-1618.5,dev_world'.
00:19:25 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,14.0,-1618.5,dev_world)'
npc='n@27'
00:19:25 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:25 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:25 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:25 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:25 [INFO] Starting TimedQueue 'NDIDNZDEEE'...
00:19:25 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:25 [INFO] Filled tag <npc.flag[current_elem].as_int> with '11'.
00:19:25 [INFO] Filled tag <npc.flag[tree_elems].get[11]> with
'l@250.5,14.0,-1618.5,dev_world'.
00:19:25 [INFO] +> Executing 'DEFINE': queue='NDIDNZDEEE'
definition='currentblock'
value='l@250.5,14.0,-1618.5,dev_world'
00:19:25 [INFO] Completing queue 'NZNEIZEEEN'.
00:19:26 [INFO] +- Executing dCommand: IF/test ---------+
00:19:26 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,14.0,-1618.5,dev_world]>
with 'true'.
00:19:26 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:26 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:26 [INFO] Filled tag <npc> with 'n@27'.
00:19:26 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:26 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:26 [INFO] Filled tag <l@250.5,14.0,-1618.5,dev_world.above> with
'l@250.5,15.0,-1618.5,dev_world'.
00:19:26 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,15.0,-1618.5,dev_world)'
npc='n@27'
00:19:26 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:26 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:26 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:26 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:26 [INFO] Starting TimedQueue 'EZDINEIZEZ'...
00:19:26 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:26 [INFO] Filled tag <npc.flag[current_elem].as_int> with '12'.
00:19:26 [INFO] Filled tag <npc.flag[tree_elems].get[12]> with
'l@250.5,15.0,-1618.5,dev_world'.
00:19:26 [INFO] +> Executing 'DEFINE': queue='EZDINEIZEZ'
definition='currentblock'
value='l@250.5,15.0,-1618.5,dev_world'
00:19:26 [INFO] Completing queue 'NDIDNZDEEE'.
00:19:27 [INFO] +- Executing dCommand: IF/test ---------+
00:19:27 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,15.0,-1618.5,dev_world]>
with 'true'.
00:19:27 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:27 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:27 [INFO] Filled tag <npc> with 'n@27'.
00:19:27 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:27 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:27 [INFO] Filled tag <l@250.5,15.0,-1618.5,dev_world.above> with
'l@250.5,16.0,-1618.5,dev_world'.
00:19:27 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,16.0,-1618.5,dev_world)'
npc='n@27'
00:19:27 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:27 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:27 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:27 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:27 [INFO] Starting TimedQueue 'NEENZENENE'...
00:19:27 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:27 [INFO] Filled tag <npc.flag[current_elem].as_int> with '13'.
00:19:27 [INFO] Filled tag <npc.flag[tree_elems].get[13]> with
'l@250.5,16.0,-1618.5,dev_world'.
00:19:27 [INFO] +> Executing 'DEFINE': queue='NEENZENENE'
definition='currentblock'
value='l@250.5,16.0,-1618.5,dev_world'
00:19:27 [INFO] Completing queue 'EZDINEIZEZ'.
00:19:28 [INFO] +- Executing dCommand: IF/test ---------+
00:19:28 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,16.0,-1618.5,dev_world]>
with 'true'.
00:19:28 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:28 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:28 [INFO] Filled tag <npc> with 'n@27'.
00:19:28 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:28 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:28 [INFO] Filled tag <l@250.5,16.0,-1618.5,dev_world.above> with
'l@250.5,17.0,-1618.5,dev_world'.
00:19:28 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,17.0,-1618.5,dev_world)'
npc='n@27'
00:19:28 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:28 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:28 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:28 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:28 [INFO] Starting TimedQueue 'NNNZNEIENN'...
00:19:28 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:28 [INFO] Filled tag <npc.flag[current_elem].as_int> with '14'.
00:19:28 [INFO] Filled tag <npc.flag[tree_elems].get[14]> with
'l@250.5,17.0,-1618.5,dev_world'.
00:19:28 [INFO] +> Executing 'DEFINE': queue='NNNZNEIENN'
definition='currentblock'
value='l@250.5,17.0,-1618.5,dev_world'
00:19:28 [INFO] Completing queue 'NEENZENENE'.
00:19:29 [INFO] +- Executing dCommand: IF/test ---------+
00:19:29 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,17.0,-1618.5,dev_world]>
with 'true'.
00:19:29 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:29 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:29 [INFO] Filled tag <npc> with 'n@27'.
00:19:29 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:29 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:29 [INFO] Filled tag <l@250.5,17.0,-1618.5,dev_world.above> with
'l@250.5,18.0,-1618.5,dev_world'.
00:19:29 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,18.0,-1618.5,dev_world)'
npc='n@27'
00:19:29 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:29 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:29 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:29 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:29 [INFO] Starting TimedQueue 'EEIDNIENIN'...
00:19:29 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:29 [INFO] Filled tag <npc.flag[current_elem].as_int> with '15'.
00:19:29 [INFO] Filled tag <npc.flag[tree_elems].get[15]> with
'l@250.5,18.0,-1618.5,dev_world'.
00:19:29 [INFO] +> Executing 'DEFINE': queue='EEIDNIENIN'
definition='currentblock'
value='l@250.5,18.0,-1618.5,dev_world'
00:19:29 [INFO] Completing queue 'NNNZNEIENN'.
00:19:30 [INFO] +- Executing dCommand: IF/test ---------+
00:19:30 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,18.0,-1618.5,dev_world]>
with 'true'.
00:19:30 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:30 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:30 [INFO] Filled tag <npc> with 'n@27'.
00:19:30 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:30 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:30 [INFO] Filled tag <l@250.5,18.0,-1618.5,dev_world.above> with
'l@250.5,19.0,-1618.5,dev_world'.
00:19:30 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,19.0,-1618.5,dev_world)'
npc='n@27'
00:19:30 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:30 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:30 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:30 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:30 [INFO] Starting TimedQueue 'NNNNININZI'...
00:19:30 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:30 [INFO] Filled tag <npc.flag[current_elem].as_int> with '16'.
00:19:30 [INFO] Filled tag <npc.flag[tree_elems].get[16]> with
'l@250.5,19.0,-1618.5,dev_world'.
00:19:30 [INFO] +> Executing 'DEFINE': queue='NNNNININZI'
definition='currentblock'
value='l@250.5,19.0,-1618.5,dev_world'
00:19:30 [INFO] Completing queue 'EEIDNIENIN'.
00:19:31 [INFO] +- Executing dCommand: IF/test ---------+
00:19:31 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,19.0,-1618.5,dev_world]>
with 'true'.
00:19:31 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:31 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:31 [INFO] Filled tag <npc> with 'n@27'.
00:19:31 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:31 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:31 [INFO] Filled tag <l@250.5,19.0,-1618.5,dev_world.above> with
'l@250.5,20.0,-1618.5,dev_world'.
00:19:31 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,20.0,-1618.5,dev_world)'
npc='n@27'
00:19:31 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:31 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:31 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:31 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:31 [INFO] Starting TimedQueue 'NENDEENNDZ'...
00:19:31 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:31 [INFO] Filled tag <npc.flag[current_elem].as_int> with '17'.
00:19:31 [INFO] Filled tag <npc.flag[tree_elems].get[17]> with
'l@250.5,20.0,-1618.5,dev_world'.
00:19:31 [INFO] +> Executing 'DEFINE': queue='NENDEENNDZ'
definition='currentblock'
value='l@250.5,20.0,-1618.5,dev_world'
00:19:31 [INFO] Completing queue 'NNNNININZI'.
00:19:32 [INFO] +- Executing dCommand: IF/test ---------+
00:19:32 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,20.0,-1618.5,dev_world]>
with 'true'.
00:19:32 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:32 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:32 [INFO] Filled tag <npc> with 'n@27'.
00:19:32 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:32 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:32 [INFO] Filled tag <l@250.5,20.0,-1618.5,dev_world.above> with
'l@250.5,21.0,-1618.5,dev_world'.
00:19:32 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,21.0,-1618.5,dev_world)'
npc='n@27'
00:19:32 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:32 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:32 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:32 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:32 [INFO] Starting TimedQueue 'ZEEDIIIIEI'...
00:19:32 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:32 [INFO] Filled tag <npc.flag[current_elem].as_int> with '18'.
00:19:32 [INFO] Filled tag <npc.flag[tree_elems].get[18]> with
'l@250.5,21.0,-1618.5,dev_world'.
00:19:32 [INFO] +> Executing 'DEFINE': queue='ZEEDIIIIEI'
definition='currentblock'
value='l@250.5,21.0,-1618.5,dev_world'
00:19:32 [INFO] Completing queue 'NENDEENNDZ'.
00:19:33 [INFO] +- Executing dCommand: IF/test ---------+
00:19:33 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,21.0,-1618.5,dev_world]>
with 'true'.
00:19:33 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:33 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:33 [INFO] Filled tag <npc> with 'n@27'.
00:19:33 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:33 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:33 [INFO] Filled tag <l@250.5,21.0,-1618.5,dev_world.above> with
'l@250.5,22.0,-1618.5,dev_world'.
00:19:33 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,22.0,-1618.5,dev_world)'
npc='n@27'
00:19:33 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:33 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:33 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:33 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:33 [INFO] Starting TimedQueue 'EDNDEEDDEZ'...
00:19:33 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:33 [INFO] Filled tag <npc.flag[current_elem].as_int> with '19'.
00:19:33 [INFO] Filled tag <npc.flag[tree_elems].get[19]> with
'l@250.5,22.0,-1618.5,dev_world'.
00:19:33 [INFO] +> Executing 'DEFINE': queue='EDNDEEDDEZ'
definition='currentblock'
value='l@250.5,22.0,-1618.5,dev_world'
00:19:33 [INFO] Completing queue 'ZEEDIIIIEI'.
00:19:34 [INFO] +- Executing dCommand: IF/test ---------+
00:19:34 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,22.0,-1618.5,dev_world]>
with 'true'.
00:19:34 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:34 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:34 [INFO] Filled tag <npc> with 'n@27'.
00:19:34 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:34 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:34 [INFO] Filled tag <l@250.5,22.0,-1618.5,dev_world.above> with
'l@250.5,23.0,-1618.5,dev_world'.
00:19:34 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,23.0,-1618.5,dev_world)'
npc='n@27'
00:19:34 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:34 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:34 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:34 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:34 [INFO] Starting TimedQueue 'INENZZIZDE'...
00:19:34 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:34 [INFO] Filled tag <npc.flag[current_elem].as_int> with '20'.
00:19:34 [INFO] Filled tag <npc.flag[tree_elems].get[20]> with
'l@250.5,23.0,-1618.5,dev_world'.
00:19:34 [INFO] +> Executing 'DEFINE': queue='INENZZIZDE'
definition='currentblock'
value='l@250.5,23.0,-1618.5,dev_world'
00:19:34 [INFO] Completing queue 'EDNDEEDDEZ'.
00:19:35 [INFO] +- Executing dCommand: IF/test ---------+
00:19:35 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,23.0,-1618.5,dev_world]>
with 'true'.
00:19:35 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:35 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:35 [INFO] Filled tag <npc> with 'n@27'.
00:19:35 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:35 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:35 [INFO] Filled tag <l@250.5,23.0,-1618.5,dev_world.above> with
'l@250.5,24.0,-1618.5,dev_world'.
00:19:35 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,24.0,-1618.5,dev_world)'
npc='n@27'
00:19:35 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:35 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:35 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:35 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:35 [INFO] Starting TimedQueue 'IZEDDNZNND'...
00:19:35 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:35 [INFO] Filled tag <npc.flag[current_elem].as_int> with '21'.
00:19:35 [INFO] Filled tag <npc.flag[tree_elems].get[21]> with
'l@250.5,24.0,-1618.5,dev_world'.
00:19:35 [INFO] +> Executing 'DEFINE': queue='IZEDDNZNND'
definition='currentblock'
value='l@250.5,24.0,-1618.5,dev_world'
00:19:35 [INFO] Completing queue 'INENZZIZDE'.
00:19:36 [INFO] +- Executing dCommand: IF/test ---------+
00:19:36 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,24.0,-1618.5,dev_world]>
with 'true'.
00:19:36 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:36 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:36 [INFO] Filled tag <npc> with 'n@27'.
00:19:36 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:36 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:36 [INFO] Filled tag <l@250.5,24.0,-1618.5,dev_world.above> with
'l@250.5,25.0,-1618.5,dev_world'.
00:19:36 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,25.0,-1618.5,dev_world)'
npc='n@27'
00:19:36 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:36 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:36 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:36 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:36 [INFO] Starting TimedQueue 'EZZNZNZZIN'...
00:19:36 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:36 [INFO] Filled tag <npc.flag[current_elem].as_int> with '22'.
00:19:36 [INFO] Filled tag <npc.flag[tree_elems].get[22]> with
'l@250.5,25.0,-1618.5,dev_world'.
00:19:36 [INFO] +> Executing 'DEFINE': queue='EZZNZNZZIN'
definition='currentblock'
value='l@250.5,25.0,-1618.5,dev_world'
00:19:36 [INFO] Completing queue 'IZEDDNZNND'.
00:19:37 [INFO] +- Executing dCommand: IF/test ---------+
00:19:37 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,25.0,-1618.5,dev_world]>
with 'true'.
00:19:37 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:37 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:37 [INFO] Filled tag <npc> with 'n@27'.
00:19:37 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:37 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:37 [INFO] Filled tag <l@250.5,25.0,-1618.5,dev_world.above> with
'l@250.5,26.0,-1618.5,dev_world'.
00:19:37 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,26.0,-1618.5,dev_world)'
npc='n@27'
00:19:37 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:37 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:37 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:37 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:37 [INFO] Starting TimedQueue 'ZIDEIDIENN'...
00:19:37 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:37 [INFO] Filled tag <npc.flag[current_elem].as_int> with '23'.
00:19:37 [INFO] Filled tag <npc.flag[tree_elems].get[23]> with
'l@250.5,26.0,-1618.5,dev_world'.
00:19:37 [INFO] +> Executing 'DEFINE': queue='ZIDEIDIENN'
definition='currentblock'
value='l@250.5,26.0,-1618.5,dev_world'
00:19:37 [INFO] Completing queue 'EZZNZNZZIN'.
00:19:38 [INFO] +- Executing dCommand: IF/test ---------+
00:19:38 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,26.0,-1618.5,dev_world]>
with 'true'.
00:19:38 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:38 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:38 [INFO] Filled tag <npc> with 'n@27'.
00:19:38 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:38 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:38 [INFO] Filled tag <l@250.5,26.0,-1618.5,dev_world.above> with
'l@250.5,27.0,-1618.5,dev_world'.
00:19:38 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,27.0,-1618.5,dev_world)'
npc='n@27'
00:19:38 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:38 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:38 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:38 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:38 [INFO] Starting TimedQueue 'IENEZENEIE'...
00:19:38 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:38 [INFO] Filled tag <npc.flag[current_elem].as_int> with '24'.
00:19:38 [INFO] Filled tag <npc.flag[tree_elems].get[24]> with
'l@250.5,27.0,-1618.5,dev_world'.
00:19:38 [INFO] +> Executing 'DEFINE': queue='IENEZENEIE'
definition='currentblock'
value='l@250.5,27.0,-1618.5,dev_world'
00:19:38 [INFO] Completing queue 'ZIDEIDIENN'.
00:19:39 [INFO] +- Executing dCommand: IF/test ---------+
00:19:39 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,27.0,-1618.5,dev_world]>
with 'true'.
00:19:39 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:39 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:39 [INFO] Filled tag <npc> with 'n@27'.
00:19:39 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:39 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:39 [INFO] Filled tag <l@250.5,27.0,-1618.5,dev_world.above> with
'l@250.5,28.0,-1618.5,dev_world'.
00:19:39 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,28.0,-1618.5,dev_world)'
npc='n@27'
00:19:39 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:39 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:39 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:39 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:39 [INFO] Starting TimedQueue 'ZNIENZEZID'...
00:19:39 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:39 [INFO] Filled tag <npc.flag[current_elem].as_int> with '25'.
00:19:39 [INFO] Filled tag <npc.flag[tree_elems].get[25]> with
'l@250.5,28.0,-1618.5,dev_world'.
00:19:39 [INFO] +> Executing 'DEFINE': queue='ZNIENZEZID'
definition='currentblock'
value='l@250.5,28.0,-1618.5,dev_world'
00:19:39 [INFO] Completing queue 'IENEZENEIE'.
00:19:40 [INFO] +- Executing dCommand: IF/test ---------+
00:19:40 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,28.0,-1618.5,dev_world]>
with 'true'.
00:19:40 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:40 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:40 [INFO] Filled tag <npc> with 'n@27'.
00:19:40 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:40 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:40 [INFO] Filled tag <l@250.5,28.0,-1618.5,dev_world.above> with
'l@250.5,29.0,-1618.5,dev_world'.
00:19:40 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,29.0,-1618.5,dev_world)'
npc='n@27'
00:19:40 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:40 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:40 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:40 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:40 [INFO] Starting TimedQueue 'ZDDEEEDZEE'...
00:19:40 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:40 [INFO] Filled tag <npc.flag[current_elem].as_int> with '26'.
00:19:40 [INFO] Filled tag <npc.flag[tree_elems].get[26]> with
'l@250.5,29.0,-1618.5,dev_world'.
00:19:40 [INFO] +> Executing 'DEFINE': queue='ZDDEEEDZEE'
definition='currentblock'
value='l@250.5,29.0,-1618.5,dev_world'
00:19:40 [INFO] Completing queue 'ZNIENZEZID'.
00:19:41 [INFO] +- Executing dCommand: IF/test ---------+
00:19:41 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,29.0,-1618.5,dev_world]>
with 'true'.
00:19:41 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:41 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:41 [INFO] Filled tag <npc> with 'n@27'.
00:19:41 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:41 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:41 [INFO] Filled tag <l@250.5,29.0,-1618.5,dev_world.above> with
'l@250.5,30.0,-1618.5,dev_world'.
00:19:41 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,30.0,-1618.5,dev_world)'
npc='n@27'
00:19:41 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:41 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:41 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:41 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:41 [INFO] Starting TimedQueue 'NIEZEIENIN'...
00:19:41 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:41 [INFO] Filled tag <npc.flag[current_elem].as_int> with '27'.
00:19:41 [INFO] Filled tag <npc.flag[tree_elems].get[27]> with
'l@250.5,30.0,-1618.5,dev_world'.
00:19:41 [INFO] +> Executing 'DEFINE': queue='NIEZEIENIN'
definition='currentblock'
value='l@250.5,30.0,-1618.5,dev_world'
00:19:41 [INFO] Completing queue 'ZDDEEEDZEE'.
00:19:42 [INFO] +- Executing dCommand: IF/test ---------+
00:19:42 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,30.0,-1618.5,dev_world]>
with 'true'.
00:19:42 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:42 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:42 [INFO] Filled tag <npc> with 'n@27'.
00:19:42 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:42 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:42 [INFO] Filled tag <l@250.5,30.0,-1618.5,dev_world.above> with
'l@250.5,31.0,-1618.5,dev_world'.
00:19:42 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,31.0,-1618.5,dev_world)'
npc='n@27'
00:19:42 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:42 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:42 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:42 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:42 [INFO] Starting TimedQueue 'ZEEZNNZZEE'...
00:19:42 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:42 [INFO] Filled tag <npc.flag[current_elem].as_int> with '28'.
00:19:42 [INFO] Filled tag <npc.flag[tree_elems].get[28]> with
'l@250.5,31.0,-1618.5,dev_world'.
00:19:42 [INFO] +> Executing 'DEFINE': queue='ZEEZNNZZEE'
definition='currentblock'
value='l@250.5,31.0,-1618.5,dev_world'
00:19:42 [INFO] Completing queue 'NIEZEIENIN'.
00:19:43 [INFO] +- Executing dCommand: IF/test ---------+
00:19:43 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,31.0,-1618.5,dev_world]>
with 'true'.
00:19:43 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:43 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:43 [INFO] Filled tag <npc> with 'n@27'.
00:19:43 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:43 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:43 [INFO] Filled tag <l@250.5,31.0,-1618.5,dev_world.above> with
'l@250.5,32.0,-1618.5,dev_world'.
00:19:43 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,32.0,-1618.5,dev_world)'
npc='n@27'
00:19:43 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:43 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:43 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:43 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:43 [INFO] Starting TimedQueue 'NNDDDDNZEZ'...
00:19:43 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:43 [INFO] Filled tag <npc.flag[current_elem].as_int> with '29'.
00:19:43 [INFO] Filled tag <npc.flag[tree_elems].get[29]> with
'l@250.5,32.0,-1618.5,dev_world'.
00:19:43 [INFO] +> Executing 'DEFINE': queue='NNDDDDNZEZ'
definition='currentblock'
value='l@250.5,32.0,-1618.5,dev_world'
00:19:43 [INFO] Completing queue 'ZEEZNNZZEE'.
00:19:44 [INFO] +- Executing dCommand: IF/test ---------+
00:19:44 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,32.0,-1618.5,dev_world]>
with 'true'.
00:19:44 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'
00:19:44 [INFO] +- Executing dCommand: ANIMATE/test ---------+
00:19:44 [INFO] Filled tag <npc> with 'n@27'.
00:19:44 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING'
entities='[n@27]'
00:19:44 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:44 [INFO] Filled tag <l@250.5,32.0,-1618.5,dev_world.above> with
'l@250.5,33.0,-1618.5,dev_world'.
00:19:44 [INFO] +> Executing 'FLAG': flag_name='TREE_ELEMS'
Action/Value='SPLIT(l@250.5,33.0,-1618.5,dev_world)'
npc='n@27'
00:19:44 [INFO] +- Executing dCommand: FLAG/test ---------+
00:19:44 [INFO] +> Executing 'FLAG': flag_name='CURRENT_ELEM'
Action/Value='INCREASE(1)' npc='n@27'
00:19:44 [INFO] +- Executing dCommand: RUN/test ---------+
00:19:44 [INFO] +> Executing 'RUN': script='CHECKBLOCKABOVE(TASK)'
00:19:44 [INFO] Starting TimedQueue 'NNNEZDNZEN'...
00:19:44 [INFO] +- Executing dCommand: DEFINE/test ---------+
00:19:44 [INFO] Filled tag <npc.flag[current_elem].as_int> with '30'.
00:19:44 [INFO] Filled tag <npc.flag[tree_elems].get[30]> with
'l@250.5,33.0,-1618.5,dev_world'.
00:19:44 [INFO] +> Executing 'DEFINE': queue='NNNEZDNZEN'
definition='currentblock'
value='l@250.5,33.0,-1618.5,dev_world'
00:19:44 [INFO] Completing queue 'NNDDDDNZEZ'.
00:19:45 [INFO] +- Executing dCommand: IF/test ---------+
00:19:45 [INFO] Filled tag
<proc[isLogAbove].context[l@250.5,33.0,-1618.5,dev_world]>
with 'true'.
00:19:45 [INFO] Comparable 1: Comparable='Boolean(true)',
Operator='EQUALS', ComparedTo='Boolean(true)' -->
OUTCOME='true'