Paste #53884: Denizen Debug Logs From A Minecraft Server

Date: 2019/04/18 17:47:02 UTC-07:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.8.0_201
Up-time: 17h 53m
CraftBukkit Version: git-Paper-614 (MC: 1.13.2)
Denizen Version: Core: 1.40-SNAPSHOT (Build 241), CraftBukkit: 1.0.4-SNAPSHOT (build 731-DEV)
Active Plugins (11): Vault: 1.7.1-b91, Essentials: 2.16.1.0, EssentialsProtect: 2.16.1.0, EssentialsSpawn: 2.16.1.0, 
EssentialsGeoIP: 2.16.1.0, EssentialsChat: 2.16.1.0, EssentialsAntiBuild: 2.16.1.0, 
Citizens: 2.0.24-SNAPSHOT (build 1628), EssentialsXMPP: 2.16.1.0, Denizen: 1.0.4-SNAPSHOT (build 731-DEV), 
Sentinel: 1.8.5 (build 242)
Loaded Worlds (3): world, world_nether, world_the_end
Online Players (1): Clossius(Clossius)
Offline Players: 0
Mode: online

17:46:55 [INFO]  Running script event 'SystemTime', event='system time secondly every:5' for script 'CALL_TASK' 
17:46:55 [INFO]  Starting InstantQueue 'CALL_TASK_AccountsDistrictsRivers'... 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FOREACH "<server.list_npcs>" 
17:46:55 [INFO] +- Executing dCommand: FOREACH ---------+ 
17:46:55 [INFO]  Filled tag <server.list_npcs> with 'li@n@5|n@4'. 
17:46:55 [INFO] +> Executing 'FOREACH': list='li@n@5|n@4'  as_name='value' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FLAG "<def[value]>" "asleep:false" 
17:46:55 [INFO] +- Executing dCommand: FLAG ---------+ 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:46:55 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(false)'  npc='n@5' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "!<def[value].has_flag[bedTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <def[value].has_flag[bedTime]> with 'true'. 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "!<def[value].has_flag[wakeTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <def[value].has_flag[wakeTime]> with 'true'. 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: DEFINE "bedTime" "<def[value].flag[bedTime]>" 
17:46:55 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:46:55 [INFO]  Filled tag <def[value].flag[bedTime]> with '12000'. 
17:46:55 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_AccountsDistrictsRivers'  definition='bedtime'  value='12000' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: DEFINE "wakeTime" "<def[value].flag[wakeTime]>" 
17:46:55 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:46:55 [INFO]  Filled tag <def[value].flag[wakeTime]> with '0'. 
17:46:55 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_AccountsDistrictsRivers'  definition='waketime'  value='0' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: INJECT "Check_Task" 
17:46:55 [INFO] +- Executing dCommand: INJECT ---------+ 
17:46:55 [INFO] +> Executing 'INJECT': script='CHECK_TASK(TASK)' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "<def[bedTime]>" ">" "<def[wakeTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <def[bedTime]> with '12000'. 
17:46:55 [INFO]  Filled tag <def[wakeTime]> with '0'. 
17:46:55 [INFO]  Comparable='Decimal(12000.0)', Operator='MORE', ComparedTo='Decimal(0.0)' --> OUTCOME='true' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "<w@world.time>" "<" "<def[wakeTime]>" "||" "<w@world.time>" ">" 
                   "<def[bedTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <w@world.time> with '22812'. 
17:46:55 [INFO]  Filled tag <def[wakeTime]> with '0'. 
17:46:55 [INFO]  Comparable='Decimal(22812.0)', Operator='LESS', ComparedTo='Decimal(0.0)' --> OUTCOME='false' 
17:46:55 [INFO]  Filled tag <w@world.time> with '22812'. 
17:46:55 [INFO]  Filled tag <def[bedTime]> with '12000'. 
17:46:55 [INFO]  Comparable='Decimal(22812.0)', Operator='MORE', ComparedTo='Decimal(12000.0)' --> OUTCOME='true' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FLAG "<def[value]>" "asleep:true" 
17:46:55 [INFO] +- Executing dCommand: FLAG ---------+ 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:46:55 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(true)'  npc='n@5' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: INJECT "Go_to_Bed" 
17:46:55 [INFO] +- Executing dCommand: INJECT ---------+ 
17:46:55 [INFO] +> Executing 'INJECT': script='GO_TO_BED(TASK)' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FLAG "<def[value]>" 
                   "localBeds:<def[value].location.find.blocks[red_bed].within[20]>" 
17:46:55 [INFO] +- Executing dCommand: FLAG ---------+ 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:46:55 [INFO]  Filled tag <def[value].location.find.blocks[red_bed].within[20]> with 'li@'. 
17:46:55 [INFO] +> Executing 'FLAG': flag_name='LOCALBEDS'  Action/Value='SET_VALUE(li@)'  npc='n@5' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: CHAT "<def[value].flag[localBeds].get[1]> | <def[value]>" 
                   "targets:<server.match_player[Clossius]>" "talkers:<def[value]>" 
17:46:55 [INFO] +- Executing dCommand: CHAT ---------+ 
17:46:55 [INFO]  Filled tag <def[value].flag[localBeds].get[1]> with 'li@'. 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:46:55 [INFO]  Filled tag <server.match_player[Clossius]> with 'p@2521ec74-80ff-40ee-852d-7ed22598c21e'. 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:46:55 [INFO] +> Executing 'CHAT': talkers='li@n@5'  targets='li@p@2521ec74-80ff-40ee-852d-7ed22598c21e'  message='li@ | n@5'  range='5' 
17:46:55 [INFO]  Filled tag <def[talker].name> with 'bowman'. 
17:46:55 [INFO]  Filled tag <def[message]> with 'li@ | n@5'. 
17:46:55 [INFO]  Filled tag <def[talker].name> with 'bowman'. 
17:46:55 [INFO]  Filled tag <def[target].name> with 'Clossius'. 
17:46:55 [INFO]  Filled tag <def[message]> with 'li@ | n@5'. 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: WALK "<def[value]>" "<player.location>" 
17:46:55 [INFO] +- Executing dCommand: WALK ---------+ 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:46:55 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_AccountsDistrictsRivers'! Invalid or missing player for tag 
                   <player.location>! 
17:46:55 [INFO]  Filled tag <player.location> with 'player.location'. 
17:46:55 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_AccountsDistrictsRivers'! Tag <player.location> is invalid! 
17:46:55 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_AccountsDistrictsRivers'! 'player.location' is an unknown argument! 
17:46:55 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_AccountsDistrictsRivers'! Woah! Invalid arguments were specified! 
17:46:55 [INFO] +> [Denizen] +> MESSAGE follows: 'Must specify a location!' 
17:46:55 [INFO] +> [Denizen] Usage: walk (<entity>|...) [<location>/stop] (speed:<#>) (auto_range) (radius:<#.#>) (lookat:<location>) 
17:46:55 [INFO] +> [Denizen] (Attempted: WALK "<def[value]>" "<player.location>") 
17:46:55 [INFO] +---------------------+ 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FOREACH " CALLBACK" "as:value" 
17:46:55 [INFO] +- Foreach loop 2 ---------+ 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FLAG "<def[value]>" "asleep:false" 
17:46:55 [INFO] +- Executing dCommand: FLAG ---------+ 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@4'. 
17:46:55 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(false)'  npc='n@4' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "!<def[value].has_flag[bedTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <def[value].has_flag[bedTime]> with 'true'. 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "!<def[value].has_flag[wakeTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <def[value].has_flag[wakeTime]> with 'true'. 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: DEFINE "bedTime" "<def[value].flag[bedTime]>" 
17:46:55 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:46:55 [INFO]  Filled tag <def[value].flag[bedTime]> with '0'. 
17:46:55 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_AccountsDistrictsRivers'  definition='bedtime'  value='0' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: DEFINE "wakeTime" "<def[value].flag[wakeTime]>" 
17:46:55 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:46:55 [INFO]  Filled tag <def[value].flag[wakeTime]> with '12000'. 
17:46:55 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_AccountsDistrictsRivers'  definition='waketime'  value='12000' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: INJECT "Check_Task" 
17:46:55 [INFO] +- Executing dCommand: INJECT ---------+ 
17:46:55 [INFO] +> Executing 'INJECT': script='CHECK_TASK(TASK)' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "<def[bedTime]>" ">" "<def[wakeTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <def[bedTime]> with '0'. 
17:46:55 [INFO]  Filled tag <def[wakeTime]> with '12000'. 
17:46:55 [INFO]  Comparable='Decimal(0.0)', Operator='MORE', ComparedTo='Decimal(12000.0)' --> OUTCOME='false' 
17:46:55 [INFO]  Filled tag <def[bedTime]> with '0'. 
17:46:55 [INFO]  Filled tag <def[wakeTime]> with '12000'. 
17:46:55 [INFO]  Comparable='Decimal(0.0)', Operator='LESS', ComparedTo='Decimal(12000.0)' --> OUTCOME='true' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: IF "<w@world.time>" "<" "<def[wakeTime]>" "&&" "<w@world.time>" ">" 
                   "<def[bedTime]>" 
17:46:55 [INFO] +- Executing dCommand: IF ---------+ 
17:46:55 [INFO] +> Executing 'IF': use_braces='true' 
17:46:55 [INFO]  Filled tag <w@world.time> with '22812'. 
17:46:55 [INFO]  Filled tag <def[wakeTime]> with '12000'. 
17:46:55 [INFO]  Comparable='Decimal(22812.0)', Operator='LESS', ComparedTo='Decimal(12000.0)' --> OUTCOME='false' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FLAG "<def[value]>" "asleep:false" 
17:46:55 [INFO] +- Executing dCommand: FLAG ---------+ 
17:46:55 [INFO]  Filled tag <def[value]> with 'n@4'. 
17:46:55 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(false)'  npc='n@4' 
17:46:55 [INFO]  Queue 'CALL_TASK_AccountsDistrictsRivers' Executing: FOREACH " CALLBACK" "as:value" 
17:46:55 [INFO] +- Foreach loop complete ---------+ 
17:46:55 [INFO]  Completing queue 'CALL_TASK_AccountsDistrictsRivers' in 30ms. 
17:46:55 [INFO]  Running script event 'SystemTime', event='system time secondly every:5' for script 'CALL_BED_TASK' 
17:46:55 [INFO]  Starting InstantQueue 'CALL_BED_TASK_SqlCarolinaFuzzy'... 
17:46:55 [INFO]  Queue 'CALL_BED_TASK_SqlCarolinaFuzzy' Executing: FOREACH "<server.flag[beds]>" 
17:46:55 [INFO] +- Executing dCommand: FOREACH ---------+ 
17:46:55 [INFO]  Filled tag <server.flag[beds]> with 'l@-122,72,-129,world|l@-119,64,-120,world'. 
17:46:55 [INFO] +> Executing 'FOREACH': list='li@l@-122,72,-129,world|l@-119,64,-120,world'  as_name='value' 
17:46:55 [INFO]  Queue 'CALL_BED_TASK_SqlCarolinaFuzzy' Executing: NARRATE "" 
17:46:55 [INFO] +- Executing dCommand: NARRATE ---------+ 
17:46:55 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
17:46:55 [INFO]  Queue 'CALL_BED_TASK_SqlCarolinaFuzzy' Executing: FOREACH " CALLBACK" "as:value" 
17:46:55 [INFO] +- Foreach loop 2 ---------+ 
17:46:55 [INFO]  Queue 'CALL_BED_TASK_SqlCarolinaFuzzy' Executing: NARRATE "" 
17:46:55 [INFO] +- Executing dCommand: NARRATE ---------+ 
17:46:55 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
17:46:55 [INFO]  Queue 'CALL_BED_TASK_SqlCarolinaFuzzy' Executing: FOREACH " CALLBACK" "as:value" 
17:46:55 [INFO] +- Foreach loop complete ---------+ 
17:46:55 [INFO]  Completing queue 'CALL_BED_TASK_SqlCarolinaFuzzy' in 4ms. 
17:47:00 [INFO]  Running script event 'SystemTime', event='system time secondly every:5' for script 'CALL_TASK' 
17:47:00 [INFO]  Starting InstantQueue 'CALL_TASK_LearnPaintballPsi'... 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FOREACH "<server.list_npcs>" 
17:47:00 [INFO] +- Executing dCommand: FOREACH ---------+ 
17:47:00 [INFO]  Filled tag <server.list_npcs> with 'li@n@5|n@4'. 
17:47:00 [INFO] +> Executing 'FOREACH': list='li@n@5|n@4'  as_name='value' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FLAG "<def[value]>" "asleep:false" 
17:47:00 [INFO] +- Executing dCommand: FLAG ---------+ 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:47:00 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(false)'  npc='n@5' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "!<def[value].has_flag[bedTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <def[value].has_flag[bedTime]> with 'true'. 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "!<def[value].has_flag[wakeTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <def[value].has_flag[wakeTime]> with 'true'. 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: DEFINE "bedTime" "<def[value].flag[bedTime]>" 
17:47:00 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:47:00 [INFO]  Filled tag <def[value].flag[bedTime]> with '12000'. 
17:47:00 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_LearnPaintballPsi'  definition='bedtime'  value='12000' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: DEFINE "wakeTime" "<def[value].flag[wakeTime]>" 
17:47:00 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:47:00 [INFO]  Filled tag <def[value].flag[wakeTime]> with '0'. 
17:47:00 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_LearnPaintballPsi'  definition='waketime'  value='0' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: INJECT "Check_Task" 
17:47:00 [INFO] +- Executing dCommand: INJECT ---------+ 
17:47:00 [INFO] +> Executing 'INJECT': script='CHECK_TASK(TASK)' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "<def[bedTime]>" ">" "<def[wakeTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <def[bedTime]> with '12000'. 
17:47:00 [INFO]  Filled tag <def[wakeTime]> with '0'. 
17:47:00 [INFO]  Comparable='Decimal(12000.0)', Operator='MORE', ComparedTo='Decimal(0.0)' --> OUTCOME='true' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "<w@world.time>" "<" "<def[wakeTime]>" "||" "<w@world.time>" ">" 
                   "<def[bedTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <w@world.time> with '22932'. 
17:47:00 [INFO]  Filled tag <def[wakeTime]> with '0'. 
17:47:00 [INFO]  Comparable='Decimal(22932.0)', Operator='LESS', ComparedTo='Decimal(0.0)' --> OUTCOME='false' 
17:47:00 [INFO]  Filled tag <w@world.time> with '22932'. 
17:47:00 [INFO]  Filled tag <def[bedTime]> with '12000'. 
17:47:00 [INFO]  Comparable='Decimal(22932.0)', Operator='MORE', ComparedTo='Decimal(12000.0)' --> OUTCOME='true' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FLAG "<def[value]>" "asleep:true" 
17:47:00 [INFO] +- Executing dCommand: FLAG ---------+ 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:47:00 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(true)'  npc='n@5' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: INJECT "Go_to_Bed" 
17:47:00 [INFO] +- Executing dCommand: INJECT ---------+ 
17:47:00 [INFO] +> Executing 'INJECT': script='GO_TO_BED(TASK)' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FLAG "<def[value]>" 
                   "localBeds:<def[value].location.find.blocks[red_bed].within[20]>" 
17:47:00 [INFO] +- Executing dCommand: FLAG ---------+ 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:47:00 [INFO]  Filled tag <def[value].location.find.blocks[red_bed].within[20]> with 'li@'. 
17:47:00 [INFO] +> Executing 'FLAG': flag_name='LOCALBEDS'  Action/Value='SET_VALUE(li@)'  npc='n@5' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: CHAT "<def[value].flag[localBeds].get[1]> | <def[value]>" 
                   "targets:<server.match_player[Clossius]>" "talkers:<def[value]>" 
17:47:00 [INFO] +- Executing dCommand: CHAT ---------+ 
17:47:00 [INFO]  Filled tag <def[value].flag[localBeds].get[1]> with 'li@'. 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:47:00 [INFO]  Filled tag <server.match_player[Clossius]> with 'p@2521ec74-80ff-40ee-852d-7ed22598c21e'. 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:47:00 [INFO] +> Executing 'CHAT': talkers='li@n@5'  targets='li@p@2521ec74-80ff-40ee-852d-7ed22598c21e'  message='li@ | n@5'  range='5' 
17:47:00 [INFO]  Filled tag <def[talker].name> with 'bowman'. 
17:47:00 [INFO]  Filled tag <def[message]> with 'li@ | n@5'. 
17:47:00 [INFO]  Filled tag <def[talker].name> with 'bowman'. 
17:47:00 [INFO]  Filled tag <def[target].name> with 'Clossius'. 
17:47:00 [INFO]  Filled tag <def[message]> with 'li@ | n@5'. 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: WALK "<def[value]>" "<player.location>" 
17:47:00 [INFO] +- Executing dCommand: WALK ---------+ 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@5'. 
17:47:00 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_LearnPaintballPsi'! Invalid or missing player for tag <player.location>! 
17:47:00 [INFO]  Filled tag <player.location> with 'player.location'. 
17:47:00 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_LearnPaintballPsi'! Tag <player.location> is invalid! 
17:47:00 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_LearnPaintballPsi'! 'player.location' is an unknown argument! 
17:47:00 [INFO]  ERROR in script 'CALL_TASK' in queue 'CALL_TASK_LearnPaintballPsi'! Woah! Invalid arguments were specified! 
17:47:00 [INFO] +> [Denizen] +> MESSAGE follows: 'Must specify a location!' 
17:47:00 [INFO] +> [Denizen] Usage: walk (<entity>|...) [<location>/stop] (speed:<#>) (auto_range) (radius:<#.#>) (lookat:<location>) 
17:47:00 [INFO] +> [Denizen] (Attempted: WALK "<def[value]>" "<player.location>") 
17:47:00 [INFO] +---------------------+ 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FOREACH " CALLBACK" "as:value" 
17:47:00 [INFO] +- Foreach loop 2 ---------+ 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FLAG "<def[value]>" "asleep:false" 
17:47:00 [INFO] +- Executing dCommand: FLAG ---------+ 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@4'. 
17:47:00 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(false)'  npc='n@4' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "!<def[value].has_flag[bedTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <def[value].has_flag[bedTime]> with 'true'. 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "!<def[value].has_flag[wakeTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <def[value].has_flag[wakeTime]> with 'true'. 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: DEFINE "bedTime" "<def[value].flag[bedTime]>" 
17:47:00 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:47:00 [INFO]  Filled tag <def[value].flag[bedTime]> with '0'. 
17:47:00 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_LearnPaintballPsi'  definition='bedtime'  value='0' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: DEFINE "wakeTime" "<def[value].flag[wakeTime]>" 
17:47:00 [INFO] +- Executing dCommand: DEFINE ---------+ 
17:47:00 [INFO]  Filled tag <def[value].flag[wakeTime]> with '12000'. 
17:47:00 [INFO] +> Executing 'DEFINE': queue='CALL_TASK_LearnPaintballPsi'  definition='waketime'  value='12000' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: INJECT "Check_Task" 
17:47:00 [INFO] +- Executing dCommand: INJECT ---------+ 
17:47:00 [INFO] +> Executing 'INJECT': script='CHECK_TASK(TASK)' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "<def[bedTime]>" ">" "<def[wakeTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <def[bedTime]> with '0'. 
17:47:00 [INFO]  Filled tag <def[wakeTime]> with '12000'. 
17:47:00 [INFO]  Comparable='Decimal(0.0)', Operator='MORE', ComparedTo='Decimal(12000.0)' --> OUTCOME='false' 
17:47:00 [INFO]  Filled tag <def[bedTime]> with '0'. 
17:47:00 [INFO]  Filled tag <def[wakeTime]> with '12000'. 
17:47:00 [INFO]  Comparable='Decimal(0.0)', Operator='LESS', ComparedTo='Decimal(12000.0)' --> OUTCOME='true' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: IF "<w@world.time>" "<" "<def[wakeTime]>" "&&" "<w@world.time>" ">" 
                   "<def[bedTime]>" 
17:47:00 [INFO] +- Executing dCommand: IF ---------+ 
17:47:00 [INFO] +> Executing 'IF': use_braces='true' 
17:47:00 [INFO]  Filled tag <w@world.time> with '22932'. 
17:47:00 [INFO]  Filled tag <def[wakeTime]> with '12000'. 
17:47:00 [INFO]  Comparable='Decimal(22932.0)', Operator='LESS', ComparedTo='Decimal(12000.0)' --> OUTCOME='false' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FLAG "<def[value]>" "asleep:false" 
17:47:00 [INFO] +- Executing dCommand: FLAG ---------+ 
17:47:00 [INFO]  Filled tag <def[value]> with 'n@4'. 
17:47:00 [INFO] +> Executing 'FLAG': flag_name='ASLEEP'  Action/Value='SET_VALUE(false)'  npc='n@4' 
17:47:00 [INFO]  Queue 'CALL_TASK_LearnPaintballPsi' Executing: FOREACH " CALLBACK" "as:value" 
17:47:00 [INFO] +- Foreach loop complete ---------+ 
17:47:00 [INFO]  Completing queue 'CALL_TASK_LearnPaintballPsi' in 25ms. 
17:47:00 [INFO]  Running script event 'SystemTime', event='system time secondly every:5' for script 'CALL_BED_TASK' 
17:47:00 [INFO]  Starting InstantQueue 'CALL_BED_TASK_TechnologyKateRemoved'... 
17:47:00 [INFO]  Queue 'CALL_BED_TASK_TechnologyKateRemoved' Executing: FOREACH "<server.flag[beds]>" 
17:47:00 [INFO] +- Executing dCommand: FOREACH ---------+ 
17:47:00 [INFO]  Filled tag <server.flag[beds]> with 'l@-122,72,-129,world|l@-119,64,-120,world'. 
17:47:00 [INFO] +> Executing 'FOREACH': list='li@l@-122,72,-129,world|l@-119,64,-120,world'  as_name='value' 
17:47:00 [INFO]  Queue 'CALL_BED_TASK_TechnologyKateRemoved' Executing: NARRATE "" 
17:47:00 [INFO] +- Executing dCommand: NARRATE ---------+ 
17:47:00 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
17:47:00 [INFO]  Queue 'CALL_BED_TASK_TechnologyKateRemoved' Executing: FOREACH " CALLBACK" "as:value" 
17:47:00 [INFO] +- Foreach loop 2 ---------+ 
17:47:00 [INFO]  Queue 'CALL_BED_TASK_TechnologyKateRemoved' Executing: NARRATE "" 
17:47:00 [INFO] +- Executing dCommand: NARRATE ---------+ 
17:47:00 [INFO] +> Executing 'NARRATE': Narrating=''  Targets='null' 
17:47:00 [INFO]  Queue 'CALL_BED_TASK_TechnologyKateRemoved' Executing: FOREACH " CALLBACK" "as:value" 
17:47:00 [INFO] +- Foreach loop complete ---------+ 
17:47:00 [INFO]  Completing queue 'CALL_BED_TASK_TechnologyKateRemoved' in 0ms.