Java Version: 1.7.0_65
CraftBukkit Version: git-Spigot-1.7.9-R0.2-205-g2c31986 (MC: 1.7.10)
Active Plugins (20): 
2zPermissions: 1.2, 
2WorldBorder: 1.7.8, 
2SignEdit: 3.3.8, 
2Warps: 0.17-SNAPSHOTb-11, 

2WorldEdit: 6.0.0-SNAPSHOT, 
2Craftconomy3: 3.1.7-SNAPSHOT jenkins-Craftconomy3-2162, 

2BungeeSuiteSpawn: 0.5b-5, 
2NoBoatBreak: 1.0, 
2Vault: 1.4.1-b${env.TRAVIS_BUILD_NUMBER}, 

2Multiverse-Core: 2.5-b688, 
2Herochat: 5.6.7-SNAPSHOT, 
2MyHelpPages: 1.4.2, 
2WorldGuard: 5.9.1-SNAPSHOT, 

2Citizens: 2.0.13-SNAPSHOT (build 1171), 
2LiftSign: 0.4.1, 
2WorldGuardFlagger: 3.4, 

2BungeeChatClient: 0.3, 
2Denizen: 0.9.6-SNAPSHOT (build mc1525.5), 
2WorldRegions: 1.0.0, 

2Depenizen: 0.2.0 (build 214)
Loaded Worlds (1): FairGrounds
Online Players (1): Nilsentience
7(Nilsentience)

21:44:37 [INFO] 
e+> 
8Executing '
eEvent
8': 
8Type='
eon UNITTEST command
8'  
8Container='
bUNIT TEST 
                   HANDLER
e(WORLD)
8'  
8Player='
eNilsentience
8'  
8Context='
e{cuboids=li@, args=li@, 
                   raw_args=, command=UNITTEST, server=false, parsed_args=li@}
8' 
21:44:37 [INFO] 
d+- Building event 'ON UNITTEST COMMAND' for UNIT TEST HANDLER ---------+ 
21:44:37 [INFO] 
d 
fStarting InstantQueue 'ZEDZIZDNNI'... 
21:44:37 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <context.server> with 'false'. 
21:44:37 [INFO] 
d 
f
eComparable 1: 
fLogic='NEGATIVE', Comparable='Element(
bfalse
f)', 
                   Operator='EQUALS', ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='true' 
21:44:37 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <player.is_op> with 'true'. 
21:44:37 [INFO] 
d 
f
eComparable 1: 
fLogic='NEGATIVE', Comparable='Element(
btrue
f)', 
                   Operator='EQUALS', ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:37 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:37 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eStarting unit tests.
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:37 [INFO] 
d+- Executing dCommand: YAML/p@Nilsentience ---------+ 
21:44:37 [INFO] 
e+> 
8Executing '
eYAML
8': id='
bUnit Test Yaml
8'  action='
bCREATE
8'  value='
b
8' 
21:44:37 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:37 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bSET_VALUE
e(0)
8'  
                   flag_target='
bserver
8' 
21:44:37 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:37 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:37 [INFO] 
d 
fStarting TimedQueue 'EEDDDNIEZD'... 
21:44:37 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:37 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '0'. 
21:44:37 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:37 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Number(
b0
f)' 
e--> OUTCOME='false' 
21:44:37 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:37 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:37 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:37 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:37 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:37 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:37 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:37 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:37 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eEEDDDNIEZD
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:37 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:37 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:37 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '1'. 
21:44:37 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@BRACKETS UNIT TEST'. 
21:44:37 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@BRACKETS UNIT TEST
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:37 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:37 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:37 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '1'. 
21:44:37 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@BRACKETS UNIT TEST'. 
21:44:37 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bBRACKETS UNIT TEST
e(WORLD)
8'  id='
btest_queue
8' 
21:44:37 [INFO] 
d+- Executing dCommand: DETERMINE/p@Nilsentience ---------+ 
21:44:37 [INFO] 
e+> 
8Executing '
eDETERMINE
8': outcome='
bfulfilled
8'  passively='
bfalse
8' 
21:44:37 [INFO] 
d 
fCompleting queue 'ZEDZIZDNNI'. 
21:44:38 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:38 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eEEDDDNIEZD
8'  
8delay='
e10t
8' 
21:44:38 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:38 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:38 [INFO] 
d 
fStarting TimedQueue 'DEENNEZENN'... 
21:44:38 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:38 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:38 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '1.0'. 
21:44:38 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:38 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b1.0
f)' 
e--> OUTCOME='false' 
21:44:38 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:38 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:38 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:38 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:38 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:38 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:38 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:38 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:38 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:38 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:38 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:38 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eDEENNEZENN
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:38 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:38 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:38 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:38 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '2'. 
21:44:38 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@PROCEDURE SCRIPT UNIT TEST'. 
21:44:38 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@PROCEDURE SCRIPT UNIT 
                   TEST
8'  
8Targets='
e[p@Nilsentience]
8' 
21:44:38 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:38 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:38 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '2'. 
21:44:38 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@PROCEDURE SCRIPT UNIT TEST'. 
21:44:38 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bPROCEDURE SCRIPT UNIT TEST
e(WORLD)
8'  
                   id='
btest_queue
8' 
21:44:38 [INFO] 
d 
fCompleting queue 'EEDDDNIEZD'. 
21:44:39 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:39 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eDEENNEZENN
8'  
8delay='
e10t
8' 
21:44:39 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:39 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:39 [INFO] 
d 
fStarting TimedQueue 'NDDNEDENNZ'... 
21:44:39 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:39 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:39 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '2.0'. 
21:44:39 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:39 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b2.0
f)' 
e--> OUTCOME='false' 
21:44:39 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:39 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:39 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:39 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:39 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:39 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:39 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:39 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:39 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:39 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:39 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:39 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eNDDNEDENNZ
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:39 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:39 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:39 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:39 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '3'. 
21:44:39 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@INJECTION UNIT TEST'. 
21:44:39 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@INJECTION UNIT TEST
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:39 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:39 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:39 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '3'. 
21:44:39 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@INJECTION UNIT TEST'. 
21:44:39 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bINJECTION UNIT TEST
e(WORLD)
8'  id='
btest_queue
8' 
21:44:39 [INFO] 
d 
fCompleting queue 'DEENNEZENN'. 
21:44:48 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:48 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eNDDNEDENNZ
8'  
8delay='
e10t
8' 
21:44:49 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:49 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:49 [INFO] 
d 
fStarting TimedQueue 'IDENENEEEE'... 
21:44:49 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:49 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:49 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '3.0'. 
21:44:49 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:49 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b3.0
f)' 
e--> OUTCOME='false' 
21:44:49 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:49 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:49 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:49 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:49 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:49 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:49 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:49 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:49 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:49 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:49 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:49 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eIDENENEEEE
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:49 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:49 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:49 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:49 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '4'. 
21:44:49 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@BOOK UNIT TEST'. 
21:44:49 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@BOOK UNIT TEST
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:49 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:49 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:49 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '4'. 
21:44:49 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@BOOK UNIT TEST'. 
21:44:49 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bBOOK UNIT TEST
e(WORLD)
8'  id='
btest_queue
8' 
21:44:49 [INFO] 
d 
fCompleting queue 'NDDNEDENNZ'. 
21:44:49 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:49 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eIDENENEEEE
8'  
8delay='
e10t
8' 
21:44:50 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:50 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:50 [INFO] 
d 
fStarting TimedQueue 'ZNIZEEEEIZ'... 
21:44:50 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:50 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:50 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '4.0'. 
21:44:50 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:50 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b4.0
f)' 
e--> OUTCOME='false' 
21:44:50 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:50 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:50 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:50 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:50 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:50 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:50 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:50 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:50 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:50 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:50 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:50 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eZNIZEEEEIZ
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:50 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:50 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:50 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:50 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '5'. 
21:44:50 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@FLAG UNIT TEST'. 
21:44:50 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@FLAG UNIT TEST
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:50 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:50 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:50 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '5'. 
21:44:50 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@FLAG UNIT TEST'. 
21:44:50 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bFLAG UNIT TEST
e(WORLD)
8'  id='
btest_queue
8' 
21:44:50 [INFO] 
d 
fCompleting queue 'IDENENEEEE'. 
21:44:51 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:51 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eZNIZEEEEIZ
8'  
8delay='
e10t
8' 
21:44:52 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:52 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:52 [INFO] 
d 
fStarting TimedQueue 'NNINENNEEE'... 
21:44:52 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:52 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:52 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '5.0'. 
21:44:52 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:52 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b5.0
f)' 
e--> OUTCOME='false' 
21:44:52 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:52 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:52 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:52 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:52 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:52 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:52 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:52 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:52 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:52 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:52 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:52 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eNNINENNEEE
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:52 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:52 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:52 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:52 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '6'. 
21:44:52 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@DINVENTORY UNIT TASK'. 
21:44:52 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@DINVENTORY UNIT TASK
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:52 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:52 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:52 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '6'. 
21:44:52 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@DINVENTORY UNIT TASK'. 
21:44:52 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bDINVENTORY UNIT TASK
e(WORLD)
8'  id='
btest_queue
8' 
21:44:52 [INFO] 
d 
fCompleting queue 'ZNIZEEEEIZ'. 
21:44:53 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:53 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eNNINENNEEE
8'  
8delay='
e10t
8' 
21:44:54 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:54 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:54 [INFO] 
d 
fStarting TimedQueue 'NNINNENIEE'... 
21:44:54 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:54 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:54 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '6.0'. 
21:44:54 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:54 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b6.0
f)' 
e--> OUTCOME='false' 
21:44:54 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:54 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:54 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:54 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:54 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:54 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:54 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:54 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:54 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:54 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:54 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:54 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eNNINNENIEE
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:54 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:54 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:54 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:54 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '7'. 
21:44:54 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@DMATERIAL UNIT TEST'. 
21:44:54 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@DMATERIAL UNIT TEST
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:54 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:54 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:54 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '7'. 
21:44:54 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@DMATERIAL UNIT TEST'. 
21:44:54 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bDMATERIAL UNIT TEST
e(WORLD)
8'  id='
btest_queue
8' 
21:44:54 [INFO] 
d 
fCompleting queue 'NNINENNEEE'. 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:54 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:55 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:55 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eNNINNENIEE
8'  
8delay='
e10t
8' 
21:44:56 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:56 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:56 [INFO] 
d 
fStarting TimedQueue 'ZNDEEEZNEI'... 
21:44:56 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:56 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:56 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '7.0'. 
21:44:56 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:56 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b7.0
f)' 
e--> OUTCOME='false' 
21:44:56 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:56 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:56 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:56 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
btrue
f)' 
e--> OUTCOME='false' 
21:44:56 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:56 [INFO] 
d 
fFilled tag <player||null> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:56 [INFO] 
d 
fFilled tag <server.list_players.get[1]> with 
                   'p@20572919-a8f6-4319-ab59-d33bbf81421d'. 
21:44:56 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:56 [INFO] 
d 
f
eComparable 1: 
fComparable='Element(
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
f)', 
                   Operator='EQUALS', ComparedTo='Element(
bnull
f)' 
e--> OUTCOME='false' 
21:44:56 [INFO] 
d+- Executing dCommand: DEFINE/p@Nilsentience ---------+ 
21:44:56 [INFO] 
d 
fFilled tag <player> with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:56 [INFO] 
e+> 
8Executing '
eDEFINE
8': 
8queue='
eZNDEEEZNEI
8'  definition='
bplayer
8'  
                   value='
bp@af5efd2a-f19b-47ef-a4bb-9c585108b3d4
8' 
21:44:56 [INFO] 
d+- Executing dCommand: FLAG/p@Nilsentience ---------+ 
21:44:56 [INFO] 
e+> 
8Executing '
eFLAG
8': flag_name='
bUT_COUNTER
8'  
8Action/Value='
bINCREASE
e(1)
8'  
                   flag_target='
bserver
8' 
21:44:56 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:56 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '8'. 
21:44:56 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@CONSTANT TAGS UNIT TASK'. 
21:44:56 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eRunning test -> s@CONSTANT TAGS UNIT TASK
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:56 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:56 [INFO] 
d 
fFilled definition %player% with 'p@af5efd2a-f19b-47ef-a4bb-9c585108b3d4'. 
21:44:56 [INFO] 
d 
fFilled tag <server.flag[ut_counter].as_int> with '8'. 
21:44:56 [INFO] 
d 
fFilled tag 
                   <server.flag[unit_tasks].as_list.get[<server.flag[ut_counter].as_int>]> with 
                   's@CONSTANT TAGS UNIT TASK'. 
21:44:56 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bCONSTANT TAGS UNIT TASK
e(WORLD)
8'  id='
btest_queue
8' 
21:44:56 [INFO] 
d 
fCompleting queue 'NNINNENIEE'. 
21:44:56 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:56 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:56 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:56 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:56 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:56 [INFO] 
d 
cERROR in script 'CONSTANT TAGS UNIT TASK'! 
fconstant: tags are deprecated! Use 
                   <npc.constant[]>! 
21:44:56 [INFO] 
d 
cERROR in script 'CONSTANT TAGS UNIT TASK'! 
fEXPECTED VALUE is an invalid 
                   dCommand! Are you sure it loaded? 
21:44:56 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:56 [INFO] 
e+> [dNPCRegistry] 
f
cDeconstructing Denizen NPC constant npc/20 
21:44:56 [INFO] 
e+> [dNPC] 
fUh oh! Denizen has encountered a NPE while trying to fetch an NPC. 
                   Has this NPC been removed? 
21:44:56 [INFO] 
d+- Executing dCommand: WAIT/p@Nilsentience ---------+ 
21:44:56 [INFO] 
e+> 
8Executing '
eWAIT
8': 
8queue='
eZNDEEEZNEI
8'  
8delay='
e10t
8' 
21:44:57 [INFO] 
e+> [dNPC] 
fUh oh! Denizen has encountered a NPE while trying to fetch an NPC. 
                   Has this NPC been removed? 
21:44:57 [INFO] 
e+> [dNPCRegistry] 
f
cRemoved NPC from dRegistry. 
21:44:57 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:57 [INFO] 
e+> 
8Executing '
eRUN
8': 
8Container='
bUNIT TEST HANDLER
e(WORLD)
8'  path='
bdo tests
8'  
                   local='
btrue
8' 
21:44:57 [INFO] 
d 
fStarting TimedQueue 'EINEZIENNI'... 
21:44:57 [INFO] 
d+- Executing dCommand: IF/p@Nilsentience ---------+ 
21:44:57 [INFO] 
d 
fFilled tag <server.flag[unit_tasks].as_list.size> with '8'. 
21:44:57 [INFO] 
d 
fFilled tag <server.flag[ut_counter]> with '8.0'. 
21:44:57 [INFO] 
d 
fFilled tag <queue.exists[test_queue]> with 'false'. 
21:44:57 [INFO] 
d 
f
eComparable 1: 
fComparable='Number(
b8
f)', Operator='OR_LESS', 
                   ComparedTo='Decimal(
b8.0
f)' 
e--> OUTCOME='true' 
21:44:57 [INFO] 
d 
f
eComparable 2: 
fComparable='Element(
bfalse
f)', Operator='EQUALS', 
                   ComparedTo='Element(
bfalse
f)' 
e--> OUTCOME='true' 
21:44:57 [INFO] 
d+- Executing dCommand: RUN/p@Nilsentience ---------+ 
21:44:57 [INFO] 
e+> 
8Executing '
eRUN
8': 
8script='
bUNIT TEST SAVE OUTPUT
e(TASK)
8' 
21:44:57 [INFO] 
d+- Executing dCommand: NARRATE/p@Nilsentience ---------+ 
21:44:57 [INFO] 
e+> 
8Executing '
eNARRATE
8': 
8Narrating='
eFinished unit tests.
8'  
                   
8Targets='
e[p@Nilsentience]
8' 
21:44:57 [INFO] 
d+- Executing dCommand: QUEUE/p@Nilsentience ---------+ 
21:44:57 [INFO] 
e+> 
8Executing '
eQUEUE
8': 
8Queue='
eEINEZIENNI
8'  
8Action='
eCLEAR
8' 
21:44:57 [INFO] 
d 
fCompleting queue 'EINEZIENNI'. 
21:44:57 [INFO] 
d 
fCompleting queue 'ZNDEEEZNEI'. 
21:44:57 [INFO] 
d 
fRe-completing queue 'EINEZIENNI'. 
21:44:57 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:57 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:57 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:57 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML' 
21:44:57 [INFO] 
d 
cERROR! 
fUnknown YAML ID 'UNIT TEST YAML'