CraftBukkit Version: git-Bukkit-1.7.2-R0.3-b3020jnks (MC: 1.7.2)
Active Plugins: 2WorldEdit: 5.5.8, 2Craftconomy3: 3.1.5 jenkins-Craftconomy3-2076, 2DwarfCraft: 1.9.3, 
2Vault: 1.2.31-b411, 2PermissionsEx: 1.20.4, 2Multiverse-Core: 2.5-b678, 2WorldGuard: 5.9, 
2Essentials: Pre2.13.1.6, 2dynmap: 1.9.2-940, 2Citizens: 2.0.11-SNAPSHOT (build 1053), 
2MagicSpells: 3.1, 2EssentialsProtect: Pre2.13.1.6, 2Denizen: 0.9.4-SNAPSHOT (build 1434), 
2EssentialsSpawn: Pre2.13.1.6, 2Multiverse-Portals: 2.5-b699, 2Sentry: 1.8.0, 
2EssentialsChat: Pre2.13.1.6, 2EssentialsAntiBuild: Pre2.13.1.6, 2Quester: 0.6.3.6, 
2dtlTraders: 3.0.9-snapshot
Loaded Worlds: Azeroth, Azeroth_nether, Azeroth_the_end, dev_world
Online Players: NLS667r7(NLS667)

22:18:01 [INFO] d+- Getting interact script: testnpc/NLS667 ---------+ 
22:18:01 [INFO] d aOKAY! f'10 LUMBERJACK LIFE' meets requirements. 
22:18:01 [INFO]  
22:18:01 [INFO] d aOKAY! fHighest scoring script is LUMBERJACK LIFE. 
22:18:01 [INFO] d+---------------------+ 
22:18:01 [INFO] d+- Parsing CLICK trigger: testnpc/NLS667 ---------+ 
22:18:01 [INFO] d fStarting TimedQueue 'IENIINNDEN'... 
22:18:01 [INFO] d+- Executing dCommand: RUN/NLS667 ---------+ 
22:18:01 [INFO] e+> 8Executing 'eRUN8': 8script='bSTARTWORKINGe(TASK)8' 
22:18:01 [INFO] d fStarting TimedQueue 'DENENNENID'... 
22:18:01 [INFO] d+- Executing dCommand: CHAT/NLS667 ---------+ 
22:18:01 [INFO] d fFilled tag <player.name> with 'NLS667'. 
22:18:01 [INFO] e+> 8Executing 'eCHAT8': 8talkers='eli@n@238'  
                   8targets='eli@p@NLS6678'  message='bOK. Im starting my work.8' 
22:18:01 [INFO] d fCompleting queue 'IENIINNDEN'. 
22:18:02 [INFO] d+- Executing dCommand: RUN/NLS667 ---------+ 
22:18:02 [INFO] e+> 8Executing 'eRUN8': 8script='bLOOKFORTREESe(TASK)8' 
22:18:02 [INFO] d fStarting TimedQueue 'IZZEENIINE'... 
22:18:02 [INFO] d+- Executing dCommand: FLAG/NLS667 ---------+ 
22:18:02 [INFO] e+> 8Executing 'eFLAG8': flag_name='bFOUND_TREES8'  
                   8Action/Value='bDELETEe(false)8'  npc='bn@238' 
22:18:02 [INFO] d fCompleting queue 'DENENNENID'. 
22:18:02 [INFO] d fCompleting queue 'IENIINNDEN'. 
22:18:02 [INFO] d+- Executing dCommand: FOREACH/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag <cons:logs> with 
                   'oak_log|birch_log|jungle_log|spruce_log|acacia_log|darkoak_log'. 
22:18:02 [INFO] d fFilled tag <cons:initialRange> with '10'. 
22:18:02 [INFO] d fFilled tag 
                   <npc.location.find.blocks[oak_log|birch_log|jungle_log|spruce_log|acacia_log|darkoak_log].within[10].as_list> 
                   with 
                   'li@l@251.5,4.0,-1609.5,dev_world|l@251.5,5.0,-1609.5,dev_world|l@251.5,6.0,-1609.5,dev_world|l@251.5,7.0,-1609.5,dev_world|l@251.5,8.0,-1609.5,dev_world|l@251.5,9.0,-1609.5,dev_world'. 
22:18:02 [INFO] e+> 8Executing 'eFOREACH8': 
                   8list='eli@l@251.5,4.0,-1609.5,dev_world|l@251.5,5.0,-1609.5,dev_world|l@251.5,6.0,-1609.5,dev_world|l@251.5,7.0,-1609.5,dev_world|l@251.5,8.0,-1609.5,dev_world|l@251.5,9.0,-1609.5,dev_world8' 
22:18:02 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag 
                   <proc[isTreeHump].context[l@251.5,4.0,-1609.5,dev_world]> 
                   with 'true'. 
22:18:02 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:02 [INFO] d+- Executing dCommand: FLAG/NLS667 ---------+ 
22:18:02 [INFO] e+> 8Executing 'eFLAG8': flag_name='bFOUND_TREES8'  
                   8Action/Value='bSPLITe(l@251.5,4.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:02 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag 
                   <proc[isTreeHump].context[l@251.5,5.0,-1609.5,dev_world]> 
                   with 'false'. 
22:18:02 [INFO] d feComparable 1: fComparable='Boolean(bfalsef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='false' 
22:18:02 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag 
                   <proc[isTreeHump].context[l@251.5,6.0,-1609.5,dev_world]> 
                   with 'false'. 
22:18:02 [INFO] d feComparable 1: fComparable='Boolean(bfalsef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='false' 
22:18:02 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag 
                   <proc[isTreeHump].context[l@251.5,7.0,-1609.5,dev_world]> 
                   with 'false'. 
22:18:02 [INFO] d feComparable 1: fComparable='Boolean(bfalsef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='false' 
22:18:02 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag 
                   <proc[isTreeHump].context[l@251.5,8.0,-1609.5,dev_world]> 
                   with 'false'. 
22:18:02 [INFO] d feComparable 1: fComparable='Boolean(bfalsef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='false' 
22:18:02 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:02 [INFO] d fFilled tag 
                   <proc[isTreeHump].context[l@251.5,9.0,-1609.5,dev_world]> 
                   with 'false'. 
22:18:02 [INFO] d feComparable 1: fComparable='Boolean(bfalsef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='false' 
22:18:03 [INFO] d+- Executing dCommand: IF/NLS667 ---------+ 
22:18:03 [INFO] d fFilled tag <npc.flag[found_trees].size.as_int> with '1'. 
22:18:03 [INFO] d feComparable 1: fComparable='Integer(b1f)', Operator='EQUALS', 
                   ComparedTo='Integer(b0f)' e--> OUTCOME='false' 
22:18:03 [INFO] d+- Executing dCommand: FLAG/NLS667 ---------+ 
22:18:03 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_TREE8'  
                   8Action/Value='bSET_VALUEe(1)8'  npc='bn@238' 
22:18:03 [INFO] d+- Executing dCommand: LOOKCLOSE/NLS667 ---------+ 
22:18:03 [INFO] d fFilled tag <npc> with 'n@23'. 
22:18:03 [INFO] e+> 8Executing 'eLOOKCLOSE8': npc='bn@238'  toggle='bfalse8' 
22:18:03 [INFO] d+- Executing dCommand: WALKTO/NLS667 ---------+ 
22:18:03 [INFO] d fFilled tag <npc> with 'n@23'. 
22:18:03 [INFO] d fFilled tag <npc.flag[current_tree].as_int> with '1'. 
22:18:03 [INFO] d fFilled tag <npc.flag[found_trees].get[1]> with 
                   'l@251.5,4.0,-1609.5,dev_world'. 
22:18:03 [INFO] e+> 8Executing 'eWALKTO8': 
                   8location='el@251.5,4.0,-1609.5,dev_world8'  
                   8npcs='e[testnpc/23]8' 
22:18:03 [INFO] d+- Executing dCommand: FLAG/NLS667 ---------+ 
22:18:03 [INFO] e+> 8Executing 'eFLAG8': flag_name='bREADY_TO_CUT8'  
                   8Action/Value='bSET_VALUEe(true)8'  npc='bn@238' 
22:18:03 [INFO] d fCompleting queue 'IZZEENIINE'. 
22:18:04 [INFO] e+> 8Executing 'eAction8': 8Type='eOn complete navigation8'  
                   8NPC='etestnpc/238'  8Container='bLUMBERJACKe(ASSIGNMENT)8' 
22:18:04 [INFO] d+- Building action 'On COMPLETE NAVIGATION' for testnpc/23 
                   ---------+ 
22:18:04 [INFO] d fStarting InstantQueue 'ZDDDZDZIED'... 
22:18:04 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:04 [INFO] d fFilled tag <npc.flag[ready_to_cut]> with 'true'. 
22:18:04 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:04 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:04 [INFO] e+> 8Executing 'eRUN8': 8script='bDEFINETREEe(TASK)8' 
22:18:04 [INFO] d fStarting TimedQueue 'EDENNZDENE'... 
22:18:04 [INFO] d+- Executing dCommand: LOOK/testnpc ---------+ 
22:18:04 [INFO] d fFilled tag <npc> with 'n@23'. 
22:18:04 [INFO] d fFilled tag <npc.flag[current_tree].as_int> with '1'. 
22:18:04 [INFO] d fFilled tag <npc.flag[found_trees].get[1]> with 
                   'l@251.5,4.0,-1609.5,dev_world'. 
22:18:04 [INFO] e+> 8Executing 'eLOOK8': 
                   8location='el@251.5,4.0,-1609.5,dev_world8'  
                   8entities='e[n@23]8' 
22:18:04 [INFO] d fCompleting queue 'ZDDDZDZIED'. 
22:18:04 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:04 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bDELETEe(false)8'  npc='bn@238' 
22:18:05 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:05 [INFO] d fFilled tag <npc.flag[current_tree]> with '1'. 
22:18:05 [INFO] d fFilled tag <npc.flag[found_trees].get[1]> with 
                   'l@251.5,4.0,-1609.5,dev_world'. 
22:18:05 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,4.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:05 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:05 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_ELEM8'  
                   8Action/Value='bSET_VALUEe(1)8'  npc='bn@238' 
22:18:06 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:06 [INFO] e+> 8Executing 'eRUN8': 8script='bCHECKBLOCKABOVEe(TASK)8' 
22:18:06 [INFO] d fStarting TimedQueue 'NDIEDNNZZI'... 
22:18:06 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:06 [INFO] d fFilled tag <npc.flag[current_elem].as_int> with '1'. 
22:18:06 [INFO] d fFilled tag <npc.flag[tree_elems].get[1]> with 
                   'l@251.5,4.0,-1609.5,dev_world'. 
22:18:06 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eNDIEDNNZZI8'  
                   8definition='ecurrentblock8'  
                   8value='el@251.5,4.0,-1609.5,dev_world8' 
22:18:06 [INFO] d fCompleting queue 'EDENNZDENE'. 
22:18:06 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:06 [INFO] d fFilled tag 
                   <proc[isLogAbove].context[l@251.5,4.0,-1609.5,dev_world]> 
                   with 'true'. 
22:18:06 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:07 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:07 [INFO] d fFilled tag <l@251.5,4.0,-1609.5,dev_world.above> with 
                   'l@251.5,5.0,-1609.5,dev_world'. 
22:18:07 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,5.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:07 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:07 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_ELEM8'  
                   8Action/Value='bINCREASEe(1)8'  npc='bn@238' 
22:18:07 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:07 [INFO] e+> 8Executing 'eRUN8': 8script='bCHECKBLOCKABOVEe(TASK)8' 
22:18:07 [INFO] d fStarting TimedQueue 'ZNIENNZZDN'... 
22:18:07 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:07 [INFO] d fFilled tag <npc.flag[current_elem].as_int> with '2'. 
22:18:07 [INFO] d fFilled tag <npc.flag[tree_elems].get[2]> with 
                   'l@251.5,5.0,-1609.5,dev_world'. 
22:18:07 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eZNIENNZZDN8'  
                   8definition='ecurrentblock8'  
                   8value='el@251.5,5.0,-1609.5,dev_world8' 
22:18:07 [INFO] d fCompleting queue 'NDIEDNNZZI'. 
22:18:07 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:07 [INFO] d fFilled tag 
                   <proc[isLogAbove].context[l@251.5,5.0,-1609.5,dev_world]> 
                   with 'true'. 
22:18:07 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:08 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:08 [INFO] d fFilled tag <l@251.5,5.0,-1609.5,dev_world.above> with 
                   'l@251.5,6.0,-1609.5,dev_world'. 
22:18:08 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,6.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:08 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:08 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_ELEM8'  
                   8Action/Value='bINCREASEe(1)8'  npc='bn@238' 
22:18:08 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:08 [INFO] e+> 8Executing 'eRUN8': 8script='bCHECKBLOCKABOVEe(TASK)8' 
22:18:08 [INFO] d fStarting TimedQueue 'ZNDZNNEEEN'... 
22:18:08 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:08 [INFO] d fFilled tag <npc.flag[current_elem].as_int> with '3'. 
22:18:08 [INFO] d fFilled tag <npc.flag[tree_elems].get[3]> with 
                   'l@251.5,6.0,-1609.5,dev_world'. 
22:18:08 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eZNDZNNEEEN8'  
                   8definition='ecurrentblock8'  
                   8value='el@251.5,6.0,-1609.5,dev_world8' 
22:18:08 [INFO] d fCompleting queue 'ZNIENNZZDN'. 
22:18:08 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:08 [INFO] d fFilled tag 
                   <proc[isLogAbove].context[l@251.5,6.0,-1609.5,dev_world]> 
                   with 'true'. 
22:18:08 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:09 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:09 [INFO] d fFilled tag <l@251.5,6.0,-1609.5,dev_world.above> with 
                   'l@251.5,7.0,-1609.5,dev_world'. 
22:18:09 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,7.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:09 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:09 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_ELEM8'  
                   8Action/Value='bINCREASEe(1)8'  npc='bn@238' 
22:18:09 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:09 [INFO] e+> 8Executing 'eRUN8': 8script='bCHECKBLOCKABOVEe(TASK)8' 
22:18:09 [INFO] d fStarting TimedQueue 'NNZEDDENNN'... 
22:18:09 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:09 [INFO] d fFilled tag <npc.flag[current_elem].as_int> with '4'. 
22:18:09 [INFO] d fFilled tag <npc.flag[tree_elems].get[4]> with 
                   'l@251.5,7.0,-1609.5,dev_world'. 
22:18:09 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eNNZEDDENNN8'  
                   8definition='ecurrentblock8'  
                   8value='el@251.5,7.0,-1609.5,dev_world8' 
22:18:09 [INFO] d fCompleting queue 'ZNDZNNEEEN'. 
22:18:09 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:09 [INFO] d fFilled tag 
                   <proc[isLogAbove].context[l@251.5,7.0,-1609.5,dev_world]> 
                   with 'true'. 
22:18:09 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:10 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:10 [INFO] d fFilled tag <l@251.5,7.0,-1609.5,dev_world.above> with 
                   'l@251.5,8.0,-1609.5,dev_world'. 
22:18:10 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,8.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:10 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:10 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_ELEM8'  
                   8Action/Value='bINCREASEe(1)8'  npc='bn@238' 
22:18:10 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:10 [INFO] e+> 8Executing 'eRUN8': 8script='bCHECKBLOCKABOVEe(TASK)8' 
22:18:10 [INFO] d fStarting TimedQueue 'EZEEZZNIEE'... 
22:18:10 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:10 [INFO] d fFilled tag <npc.flag[current_elem].as_int> with '5'. 
22:18:10 [INFO] d fFilled tag <npc.flag[tree_elems].get[5]> with 
                   'l@251.5,8.0,-1609.5,dev_world'. 
22:18:10 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eEZEEZZNIEE8'  
                   8definition='ecurrentblock8'  
                   8value='el@251.5,8.0,-1609.5,dev_world8' 
22:18:10 [INFO] d fCompleting queue 'NNZEDDENNN'. 
22:18:10 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:10 [INFO] d fFilled tag 
                   <proc[isLogAbove].context[l@251.5,8.0,-1609.5,dev_world]> 
                   with 'true'. 
22:18:10 [INFO] d feComparable 1: fComparable='Boolean(btruef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='true' 
22:18:11 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:11 [INFO] d fFilled tag <l@251.5,8.0,-1609.5,dev_world.above> with 
                   'l@251.5,9.0,-1609.5,dev_world'. 
22:18:11 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,9.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:11 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:11 [INFO] e+> 8Executing 'eFLAG8': flag_name='bCURRENT_ELEM8'  
                   8Action/Value='bINCREASEe(1)8'  npc='bn@238' 
22:18:11 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:11 [INFO] e+> 8Executing 'eRUN8': 8script='bCHECKBLOCKABOVEe(TASK)8' 
22:18:11 [INFO] d fStarting TimedQueue 'DEIDEDNNEN'... 
22:18:11 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:11 [INFO] d fFilled tag <npc.flag[current_elem].as_int> with '6'. 
22:18:11 [INFO] d fFilled tag <npc.flag[tree_elems].get[6]> with 
                   'l@251.5,9.0,-1609.5,dev_world'. 
22:18:11 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eDEIDEDNNEN8'  
                   8definition='ecurrentblock8'  
                   8value='el@251.5,9.0,-1609.5,dev_world8' 
22:18:11 [INFO] d fCompleting queue 'EZEEZZNIEE'. 
22:18:11 [INFO] d+- Executing dCommand: IF/testnpc ---------+ 
22:18:11 [INFO] d fFilled tag 
                   <proc[isLogAbove].context[l@251.5,9.0,-1609.5,dev_world]> 
                   with 'false'. 
22:18:11 [INFO] d feComparable 1: fComparable='Boolean(bfalsef)', 
                   Operator='EQUALS', ComparedTo='Boolean(btruef)' e--> 
                   OUTCOME='false' 
22:18:12 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eRUN8': 8script='bLOOKFORLEAVESe(TASK)8' 
22:18:12 [INFO] d fStarting TimedQueue 'EIZDNNNEEN'... 
22:18:12 [INFO] d+- Executing dCommand: DEFINE/testnpc ---------+ 
22:18:12 [INFO] d fFilled tag <npc.flag[tree_elems].size.as_int> with '6'. 
22:18:12 [INFO] d fFilled tag <npc.flag[tree_elems].get[6]> with 
                   'l@251.5,9.0,-1609.5,dev_world'. 
22:18:12 [INFO] e+> 8Executing 'eDEFINE8': 8queue='eEIZDNNNEEN8'  
                   8definition='etopblock8'  
                   8value='el@251.5,9.0,-1609.5,dev_world8' 
22:18:12 [INFO] d fCompleting queue 'DEIDEDNNEN'. 
22:18:12 [INFO] d+- Executing dCommand: FOREACH/testnpc ---------+ 
22:18:12 [INFO] d fFilled tag <cons:leaves> with 
                   'oak_leaves|birch_leaves|jungle_leaves|spruce_leaves|acacia_leaves|darkoak_leaves'. 
22:18:12 [INFO] d fFilled tag 
                   <l@251.5,9.0,-1609.5,dev_world.find.blocks[oak_leaves|birch_leaves|jungle_leaves|spruce_leaves|acacia_leaves|darkoak_leaves].within[5].as_list> 
                   with 
                   'li@l@251.5,9.0,-1608.5,dev_world|l@252.5,9.0,-1609.5,dev_world|l@251.5,8.0,-1610.5,dev_world|l@251.5,8.0,-1608.5,dev_world|l@251.5,10.0,-1608.5,dev_world|l@252.5,10.0,-1609.5,dev_world|l@250.5,8.0,-1608.5,dev_world|l@249.5,8.0,-1609.5,dev_world|l@250.5,7.0,-1609.5,dev_world|l@251.5,7.0,-1610.5,dev_world|l@251.5,8.0,-1611.5,dev_world|l@251.5,8.0,-16... 
                   * snip! * 
22:18:12 [INFO] e+> 8Executing 'eFOREACH8': 
                   8list='eli@l@251.5,9.0,-1608.5,dev_world|l@252.5,9.0,-1609.5,dev_world|l@251.5,8.0,-1610.5,dev_world|l@251.5,8.0,-1608.5,dev_world|l@251.5,10.0,-1608.5,dev_world|l@252.5,10.0,-1609.5,dev_world|l@250.5,8.0,-1608.5,dev_world|l@249.5,8.0,-1609.5,dev_world|l@250.5,7.0,-1609.5,dev_world|l@251.5,7.0,-1610.5,dev_world|l@251.5,8.0,-1611.5,dev_world|l@251.5,8.0,-1607.5,dev_world|l@252.5,7.0,-1609.5,dev_world|l@253.5,8.0,-1609.5,dev_world|l@249.5,8.0,-1610.5,dev_world|l@249.5,8.0,-1608.5,dev_world|l@250.5,7.0,-1... 
                   * snip! * 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,9.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,9.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,8.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,8.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,10.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,10.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,8.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,8.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,7.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,7.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,8.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,8.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,7.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,8.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,8.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,8.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,7.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,7.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,8.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,8.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,7.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,8.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,8.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,8.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,8.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,7.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,7.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@251.5,7.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,7.0,-1609.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,7.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,7.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,8.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,7.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@250.5,7.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,7.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@252.5,7.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,7.0,-1610.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,7.0,-1608.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,8.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,8.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,7.0,-1611.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@249.5,7.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:12 [INFO] d+- Executing dCommand: FLAG/testnpc ---------+ 
22:18:12 [INFO] e+> 8Executing 'eFLAG8': flag_name='bTREE_ELEMS8'  
                   8Action/Value='bSPLITe(l@253.5,7.0,-1607.5,dev_world)8'  
                   npc='bn@238' 
22:18:13 [INFO] d+- Executing dCommand: RUN/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eRUN8': 8script='bCUTTREEe(TASK)8' 
22:18:13 [INFO] d fStarting TimedQueue 'ZZEZNIEEEN'... 
22:18:13 [INFO] d+- Executing dCommand: FOREACH/testnpc ---------+ 
22:18:13 [INFO] d fFilled tag <npc.flag[tree_elems].as_list> with 
                   'li@l@251.5,4.0,-1609.5,dev_world|l@251.5,5.0,-1609.5,dev_world|l@251.5,6.0,-1609.5,dev_world|l@251.5,7.0,-1609.5,dev_world|l@251.5,8.0,-1609.5,dev_world|l@251.5,9.0,-1609.5,dev_world|l@251.5,9.0,-1608.5,dev_world|l@252.5,9.0,-1609.5,dev_world|l@251.5,8.0,-1610.5,dev_world|l@251.5,8.0,-1608.5,dev_world|l@251.5,10.0,-1608.5,dev_world|l@252.5,10.0,-1609.5,dev_world|l@250.5,8.0,-1608.5,dev_world|l@249.5,8.0,-1609.5,dev_world|l@250.5,7.0,-1609.5,dev_world|l@251.5,... 
                   * snip! * 
22:18:13 [INFO] e+> 8Executing 'eFOREACH8': 
                   8list='eli@l@251.5,4.0,-1609.5,dev_world|l@251.5,5.0,-1609.5,dev_world|l@251.5,6.0,-1609.5,dev_world|l@251.5,7.0,-1609.5,dev_world|l@251.5,8.0,-1609.5,dev_world|l@251.5,9.0,-1609.5,dev_world|l@251.5,9.0,-1608.5,dev_world|l@252.5,9.0,-1609.5,dev_world|l@251.5,8.0,-1610.5,dev_world|l@251.5,8.0,-1608.5,dev_world|l@251.5,10.0,-1608.5,dev_world|l@252.5,10.0,-1609.5,dev_world|l@250.5,8.0,-1608.5,dev_world|l@249.5,8.0,-1609.5,dev_world|l@250.5,7.0,-1609.5,dev_world|l@251.5,7.0,-1610.5,dev_world|l@251.5,8.0,-1... 
                   * snip! * 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,4.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,5.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,6.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,7.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,8.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,9.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,9.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,9.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,8.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,8.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,10.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,10.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,8.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,8.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,7.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,7.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,8.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,8.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,7.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,8.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,8.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,8.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,7.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,7.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,8.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,8.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,7.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,8.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,8.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,8.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,8.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,7.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,7.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@251.5,7.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,7.0,-1609.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,7.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,7.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,8.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,7.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@250.5,7.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,7.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@252.5,7.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,7.0,-1610.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,7.0,-1608.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,8.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,8.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,7.0,-1611.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@249.5,7.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d+- Executing dCommand: MODIFYBLOCK/testnpc ---------+ 
22:18:13 [INFO] e+> 8Executing 'eMODIFYBLOCK8': 
                   8locations='e[l@253.5,7.0,-1607.5,dev_world]8'  
                   material='bm@air8'  radius='b08'  height='b08'  depth='b08' 
22:18:13 [INFO] d fCompleting queue 'ZZEZNIEEEN'. 
22:18:13 [INFO] d fCompleting queue 'EIZDNNNEEN'. 
22:18:13 [INFO] d fCompleting queue 'ZZEZNIEEEN'.