Paste #8880: Denizen Debug Logs From 9l?bl?9l?bl?9l?bl?9l?bl? elM6lineelC6lonomy el

Date: 2014/08/26 15:55:54 UTC-07:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.7.0_65
CraftBukkit Version: git-Spigot-1591 (MC: 1.7.10)
Active Plugins (7): zPermissions: 1.3-SNAPSHOT, Vault: 1.4.1-b${env.TRAVIS_BUILD_NUMBER}, Votifier: 1.9, 
Citizens: 2.0.13-SNAPSHOT (build 1165), DonationPoints: 1.10.0, Denizen: 0.9.5-SNAPSHOT (build mc1515.5), 
Depenizen: 0.2.0 (build 214)
Loaded Worlds (1): Spawn
Online Players (0): No Online Players

19:07:51 [INFO] +> Executing 'Event': Type='on DEFS command'  
                   Container='DEFINITION_EXAMPLE(WORLD)'  
                   Context='{args=li@This|is|a|test|sentence!, raw_args=This is a test sentence!, 
                   command=DEFS, server=true, parsed_args=li@This|is|a|test|sentence!}' 
19:07:51 [INFO] +- Building event 'ON DEFS COMMAND' for DEFINITION_EXAMPLE ---------+ 
19:07:51 [INFO]  Starting InstantQueue 'NZEENDEDEI'... 
19:07:51 [INFO] +- Executing dCommand: DETERMINE ---------+ 
19:07:51 [INFO] +> Executing 'DETERMINE': outcome='fulfilled'  passively='true' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled tag <c.args> with 'li@This|is|a|test|sentence!'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NZEENDEDEI'  definition='args'  
                   value='li@This|is|a|test|sentence!' 
19:07:51 [INFO] +- Executing dCommand: RUN ---------+ 
19:07:51 [INFO]  Filled definition %args% with 'li@This|is|a|test|sentence!'. 
19:07:51 [INFO] +> Executing 'RUN': Container='DEFINITION_EXAMPLE(WORLD)'  instant='true'  
                   path='defs'  local='true' 
19:07:51 [INFO]  Adding definition %1% as This 
19:07:51 [INFO]  Adding definition %2% as is 
19:07:51 [INFO]  Adding definition %3% as a 
19:07:51 [INFO]  Adding definition %4% as test 
19:07:51 [INFO]  Adding definition %5% as sentence! 
19:07:51 [INFO]  Starting InstantQueue 'NDNZIIEDEN'... 
19:07:51 [INFO] +- Executing dCommand: FOREACH ---------+ 
19:07:51 [INFO]  Filled tag <def[1].as_list> with 'li@This'. 
19:07:51 [INFO] +> Executing 'FOREACH': list='li@This' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %loop_index% with '1'. 
19:07:51 [INFO]  Filled definition %value% with 'This'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='word_1'  value='This' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled tag <queue.definitions> with 'li@word_1|2|3|loop_index|value|5|4|1'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='defs'  
                   value='li@word_1|2|3|loop_index|value|5|4|1' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&3> with ''. 
19:07:51 [INFO]  Filled tag <&n> with ''. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating=' Words Used'  Targets='null' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
19:07:51 [INFO] +- Executing dCommand: FOREACH ---------+ 
19:07:51 [INFO]  Filled definition %defs% with 'li@word_1|2|3|loop_index|value|5|4|1'. 
19:07:51 [INFO] +> Executing 'FOREACH': list='li@word_1|2|3|loop_index|value|5|4|1' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with 'word_1'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='word_1' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with 'word_1'. 
19:07:51 [INFO]  Filled definition %def% with 'word_1'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[word_1]> with 'This'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   word_1: This'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 2 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '2'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='2' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '2'. 
19:07:51 [INFO]  Filled definition %def% with '2'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[2]> with 'is'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   2: is'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 3 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '3'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='3' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '3'. 
19:07:51 [INFO]  Filled definition %def% with '3'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[3]> with 'a'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   3: a'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 4 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with 'loop_index'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  
                   value='loop_index' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with 'loop_index'. 
19:07:51 [INFO]  Filled definition %def% with 'loop_index'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[loop_index]> with '4'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   loop_index: 4'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 5 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with 'value'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='value' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with 'value'. 
19:07:51 [INFO]  Filled definition %def% with 'value'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[value]> with 'value'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   value: value'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 6 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '5'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='5' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '5'. 
19:07:51 [INFO]  Filled definition %def% with '5'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[5]> with 'sentence!'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   5: sentence!'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 7 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '4'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='4' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '4'. 
19:07:51 [INFO]  Filled definition %def% with '4'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[4]> with 'test'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   4: test'  Targets='null' 
19:07:51 [INFO] +- Foreach loop 8 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '1'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='1' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '1'. 
19:07:51 [INFO]  Filled definition %def% with '1'. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&sp> with ' '. 
19:07:51 [INFO]  Filled tag <&6> with ''. 
19:07:51 [INFO]  Filled tag <&co> with ':'. 
19:07:51 [INFO]  Filled tag <&f> with ''. 
19:07:51 [INFO]  Filled tag <def[1]> with 'This'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='   1: This'  Targets='null' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled tag <def[defs].alphanumeric> with 
                   'li@1|2|3|4|5|loop_index|value|word_1'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='defs'  
                   value='li@1|2|3|4|5|loop_index|value|word_1' 
19:07:51 [INFO] +- Executing dCommand: FOREACH ---------+ 
19:07:51 [INFO]  Filled definition %defs% with 'li@1|2|3|4|5|loop_index|value|word_1'. 
19:07:51 [INFO] +> Executing 'FOREACH': list='li@1|2|3|4|5|loop_index|value|word_1' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '1'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='1' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '1'. 
19:07:51 [INFO]  Filled definition %def% with '1'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'false'. 
19:07:51 [INFO]  Filled tag <def[1]> with 'This'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[This]||null> with 'null'. 
19:07:51 [INFO]  Filled tag <def[1]> with 'This'. 
19:07:51 [INFO]  Filled tag <tern[false]:null || This> with 'This'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  value='This' 
19:07:51 [INFO] +- Foreach loop 2 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '2'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='2' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '2'. 
19:07:51 [INFO]  Filled definition %def% with '2'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[2]> with 'is'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[is]||null> with 'li@This|is'. 
19:07:51 [INFO]  Filled tag <def[2]> with 'is'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is || is> with 'li@This|is'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is' 
19:07:51 [INFO] +- Foreach loop 3 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '3'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='3' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '3'. 
19:07:51 [INFO]  Filled definition %def% with '3'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[3]> with 'a'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[a]||null> with 'li@This|is|a'. 
19:07:51 [INFO]  Filled tag <def[3]> with 'a'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is|a || a> with 'li@This|is|a'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is|a' 
19:07:51 [INFO] +- Foreach loop 4 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '4'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='4' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '4'. 
19:07:51 [INFO]  Filled definition %def% with '4'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[4]> with 'test'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[test]||null> with 
                   'li@This|is|a|test'. 
19:07:51 [INFO]  Filled tag <def[4]> with 'test'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is|a|test || test> with 'li@This|is|a|test'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is|a|test' 
19:07:51 [INFO] +- Foreach loop 5 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with '5'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='5' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with '5'. 
19:07:51 [INFO]  Filled definition %def% with '5'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[5]> with 'sentence!'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[sentence!]||null> with 
                   'li@This|is|a|test|sentence!'. 
19:07:51 [INFO]  Filled tag <def[5]> with 'sentence!'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is|a|test|sentence! || sentence!> with 
                   'li@This|is|a|test|sentence!'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is|a|test|sentence!' 
19:07:51 [INFO] +- Foreach loop 6 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with 'loop_index'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  
                   value='loop_index' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with 'loop_index'. 
19:07:51 [INFO]  Filled definition %def% with 'loop_index'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[loop_index]> with '6'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[6]||null> with 
                   'li@This|is|a|test|sentence!|6'. 
19:07:51 [INFO]  Filled tag <def[loop_index]> with '6'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is|a|test|sentence!|6 || 6> with 
                   'li@This|is|a|test|sentence!|6'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is|a|test|sentence!|6' 
19:07:51 [INFO] +- Foreach loop 7 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with 'value'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='value' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with 'value'. 
19:07:51 [INFO]  Filled definition %def% with 'value'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[value]> with 'value'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[value]||null> with 
                   'li@This|is|a|test|sentence!|6|value'. 
19:07:51 [INFO]  Filled tag <def[value]> with 'value'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is|a|test|sentence!|6|value || value> with 
                   'li@This|is|a|test|sentence!|6|value'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is|a|test|sentence!|6|value' 
19:07:51 [INFO] +- Foreach loop 8 ---------+ 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %value% with 'word_1'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='def'  value='word_1' 
19:07:51 [INFO] +- Executing dCommand: DEFINE ---------+ 
19:07:51 [INFO]  Filled definition %def% with 'word_1'. 
19:07:51 [INFO]  Filled definition %def% with 'word_1'. 
19:07:51 [INFO]  Filled tag <def[sentence].exists> with 'true'. 
19:07:51 [INFO]  Filled tag <def[word_1]> with 'This'. 
19:07:51 [INFO]  Filled tag <def[sentence].as_list.include[This]||null> with 
                   'li@This|is|a|test|sentence!|6|value|This'. 
19:07:51 [INFO]  Filled tag <def[word_1]> with 'This'. 
19:07:51 [INFO]  Filled tag <tern[true]:li@This|is|a|test|sentence!|6|value|This || This> with 
                   'li@This|is|a|test|sentence!|6|value|This'. 
19:07:51 [INFO] +> Executing 'DEFINE': queue='NDNZIIEDEN'  definition='sentence'  
                   value='li@This|is|a|test|sentence!|6|value|This' 
19:07:51 [INFO] +- Executing dCommand: NARRATE ---------+ 
19:07:51 [INFO]  Filled tag <def[sentence].space_separated> with 'This is a test sentence! 6 
                   value This'. 
19:07:51 [INFO] +> Executing 'NARRATE': Narrating='This is a test sentence! 6 value This'  
                   Targets='null' 
19:07:51 [INFO]  Completing queue 'NDNZIIEDEN'. 
19:07:51 [INFO]  Completing queue 'NZEENDEDEI'.