Paste #1855: Denizen Debug Logs From Kingdoms of Resdayn

Date: 2014/02/07 07:04:51 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


CraftBukkit Version: git-Bukkit-1.7.2-R0.2-b2974jnks (MC: 1.7.2)
Active Plugins: WorldBorder: 1.5.4, CopyBook: 1.14, HorseKeep: 0.1.3, WorldEdit: 5.5.8, ColoredSigns: 1.2, 
LogBlockQuestioner: 0.02, Vault: 1.2.27-b349, Multiverse-Core: 2.4-b526, PermissionsEx: 1.19.6, 
LogBlock: 1.70, WorldGuard: 5.8, iConomy: 7.0, pvparena: 1.1.0.351, Lockette: 1.7.12, 
Runecraft: 2.17.2 dev #41, mcMMO: 1.4.07-beta1-b2226, MobArena: 0.95.5, ForcedGrammar: 1.8.1, 
DeathTpPlus: 3.9.16.2320, EnchantPlus: 1.2.0, Easy_Fireworks: 4.7, Essentials: 2.12.1, 
Citizens: 2.0.11-SNAPSHOT (build 1027), XrayInformer: 2.2.0, EssentialsSpawn: 2.12.1, 
Multiverse-Portals: 2.4-b544, CommandShops: 4.2.2, Denizen: 0.9.3-SNAPSHOT (build 1407), 
Sentry: 1.7.1
Loaded Worlds: world, world_nether, world_the_end, world_jungle, Velothi_Mountains
Online Players: ~Chicken(UrSubconscious), Ivan0vic(Ivan0vic)

06:06:41 [INFO] +- Getting interact script: Melaire/UrSubconscious 
                   ---------+ 
06:06:41 [INFO]  CHECK! Now checking 'ALCHEMY QUEST STATUS' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:41 [INFO] +> [InteractScri...] '5 ALCHEMY QUEST STATUS' does not 
                   meet requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  CHECK! Now checking 'ALCHEMY QUEST LINE' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:41 [INFO] +> [InteractScri...] '10 ALCHEMY QUEST LINE' does not meet 
                   requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  CHECK! Now checking 'ALCHEMY QUEST ONE' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:41 [INFO]  Filled tag <Brown_MushroomQty> with '9'. 
06:06:41 [INFO]  ...player has i@brown_mushroom. 
06:06:41 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:41 [INFO] +> [InteractScri...] '20 ALCHEMY QUEST ONE' does not meet 
                   requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  CHECK! Now checking 'ALCHEMY QUEST TWO' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:41 [INFO]  Filled tag <Spider_EyeQty> with '10'. 
06:06:41 [INFO]  ...player has i@spider_eye. 
06:06:41 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:41 [INFO] +> [InteractScri...] '21 ALCHEMY QUEST TWO' does not meet 
                   requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  CHECK! Now checking 'ALCHEMY QUEST THREE' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:41 [INFO]  Filled tag <GunpowderQty> with '12'. 
06:06:41 [INFO]  ...player has i@sulphur. 
06:06:41 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:41 [INFO] +> [InteractScri...] '22 ALCHEMY QUEST THREE' does not 
                   meet requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  CHECK! Now checking 'ALCHEMY QUEST FOUR' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  ... does not match 'Completed'. 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:41 [INFO]  Filled tag <EnderPearlQty> with '16'. 
06:06:41 [INFO]  ...player has i@ender_pearl. 
06:06:41 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:41 [INFO] +> [InteractScri...] '23 ALCHEMY QUEST FOUR' does not meet 
                   requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  CHECK! Now checking 'CREATE POTION' 
06:06:41 [INFO]  Requirement mode: 'ALL' 
06:06:41 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:41 [INFO]  OKAY! '30 CREATE POTION' meets requirements. 
06:06:41 [INFO]  
06:06:41 [INFO]  OKAY! Highest scoring script is CREATE POTION. 
06:06:41 [INFO] +---------------------+ 
06:06:41 [INFO] +- Parsing CLICK trigger: Melaire/UrSubconscious 
                   ---------+ 
06:06:41 [INFO] +- Executing dCommand: engage/UrSubconscious ---------+ 
06:06:41 [INFO] +> Executing 'ENGAGE': NPC='Melaire/14'  duration='300t' 
06:06:41 [INFO] +- Executing dCommand: IF/UrSubconscious ---------+ 
06:06:41 [INFO]  Filled tag <player.item_in_hand.id> with '391'. 
06:06:41 [INFO]  Comparable 1: Comparable='dList(li@267|268|272|276)', 
                   Operator='CONTAINS', ComparedTo='String(391)' --> 
                   OUTCOME='false' 
06:06:41 [INFO]  Starting TimedQueue 
                   'C32F2C47-AAA4-4983-9E19-8792CC83397E' 
06:06:42 [INFO] +- Executing dCommand: RUNTASK/UrSubconscious ---------+ 
06:06:42 [INFO] +> [RuntaskCommand] Notice: This command has been 
                   deprecated. Use instead 'run' or 'inject'! While this 
                   command will continue to work for now, RUNTASK's new 
                   counterparts are more efficient and powerful! 
06:06:42 [INFO] +> Executing 'RUNTASK': script='CREATE POTION 
                   DIALOG(TASK)'  Instant='false'  
                   Queue='C32F2C47-AAA4-4983-9E19-8792CC83397E'  
                   Player='UrSubconscious'  NPC='Melaire/14' 
06:06:42 [INFO] +- Executing dCommand: engage/UrSubconscious ---------+ 
06:06:42 [INFO] +> Executing 'ENGAGE': NPC='Melaire/14'  duration='300t' 
06:06:42 [INFO] +- Executing dCommand: CHAT/UrSubconscious ---------+ 
06:06:42 [INFO] +> Executing 'CHAT': talkers='li@n@14'  
                   targets='p@UrSubconscious'  message='What Potion would you 
                   like me to make?' 
06:06:42 [INFO] +- Executing dCommand: WAIT/UrSubconscious ---------+ 
06:06:42 [INFO]  Delaying 20t 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <red> with ''. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating='Say:'  
                   Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <gold> with ''. 
06:06:43 [INFO]  Filled tag <PotionFee> with '50'. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating='Fire Resistance     - 
                   50 coins'  Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <gold> with ''. 
06:06:43 [INFO]  Filled tag <PotionFee> with '50'. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating='Nightvision    - 50 
                   coins'  Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <green> with ''. 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <gold> with ''. 
06:06:43 [INFO]  Filled tag <PotionFee> with '50'. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating='Swiftness  - 50 coins'  
                   Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <green> with ''. 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <gold> with ''. 
06:06:43 [INFO]  Filled tag <PotionFee> with '50'. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating='Regeneration   - 50 
                   coins'  Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <green> with ''. 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <gold> with ''. 
06:06:43 [INFO]  Filled tag <PotionFee> with '50'. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating='Strength  - 50 coins'  
                   Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: narrate/UrSubconscious ---------+ 
06:06:43 [INFO]  Filled tag <red> with ''. 
06:06:43 [INFO]  Filled tag <blue> with ''. 
06:06:43 [INFO]  Filled tag <red> with ''. 
06:06:43 [INFO] +> Executing 'NARRATE': Narrating=''Nevermind' if you're 
                   not interested in getting Potions.'  
                   Targets='[p@UrSubconscious]' 
06:06:43 [INFO] +- Executing dCommand: disengage/UrSubconscious ---------+ 
06:06:43 [INFO] +> Executing 'DISENGAGE': NPC='Melaire/14' 
06:06:43 [INFO] +- Executing dCommand: zap/UrSubconscious ---------+ 
06:06:43 [INFO] +> Executing 'ZAP': targets='p@UrSubconscious'  
                   script='CREATE POTION(INTERACT)'  step='3' 
06:06:43 [INFO] +- Executing dCommand: disengage/UrSubconscious ---------+ 
06:06:43 [INFO] +> Executing 'DISENGAGE': NPC='Melaire/14' 
06:06:43 [INFO]  Completing queue C32F2C47-AAA4-4983-9E19-8792CC83397E... 
06:06:52 [INFO] +- Getting interact script: Melaire/UrSubconscious 
                   ---------+ 
06:06:52 [INFO]  CHECK! Now checking 'ALCHEMY QUEST STATUS' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:52 [INFO] +> [InteractScri...] '5 ALCHEMY QUEST STATUS' does not 
                   meet requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  CHECK! Now checking 'ALCHEMY QUEST LINE' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:52 [INFO] +> [InteractScri...] '10 ALCHEMY QUEST LINE' does not meet 
                   requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  CHECK! Now checking 'ALCHEMY QUEST ONE' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:52 [INFO]  Filled tag <Brown_MushroomQty> with '9'. 
06:06:52 [INFO]  ...player has i@brown_mushroom. 
06:06:52 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:52 [INFO] +> [InteractScri...] '20 ALCHEMY QUEST ONE' does not meet 
                   requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  CHECK! Now checking 'ALCHEMY QUEST TWO' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:52 [INFO]  Filled tag <Spider_EyeQty> with '10'. 
06:06:52 [INFO]  ...player has i@spider_eye. 
06:06:52 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:52 [INFO] +> [InteractScri...] '21 ALCHEMY QUEST TWO' does not meet 
                   requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  CHECK! Now checking 'ALCHEMY QUEST THREE' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:52 [INFO]  Filled tag <GunpowderQty> with '12'. 
06:06:52 [INFO]  ...player has i@sulphur. 
06:06:52 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:52 [INFO] +> [InteractScri...] '22 ALCHEMY QUEST THREE' does not 
                   meet requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  CHECK! Now checking 'ALCHEMY QUEST FOUR' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  ... does not match 'Completed'. 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement not met! 
06:06:52 [INFO]  Filled tag <EnderPearlQty> with '16'. 
06:06:52 [INFO]  ...player has i@ender_pearl. 
06:06:52 [INFO]  OKAY! Checked 'ITEM' ...requirement met! 
06:06:52 [INFO] +> [InteractScri...] '23 ALCHEMY QUEST FOUR' does not meet 
                   requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  CHECK! Now checking 'CREATE POTION' 
06:06:52 [INFO]  Requirement mode: 'ALL' 
06:06:52 [INFO]  OKAY! Checked 'FLAGGED' ...requirement met! 
06:06:52 [INFO]  OKAY! '30 CREATE POTION' meets requirements. 
06:06:52 [INFO]  
06:06:52 [INFO]  OKAY! Highest scoring script is CREATE POTION. 
06:06:52 [INFO] +---------------------+ 
06:06:52 [INFO] +> Executing 'CHAT': Player='UrSubconscious'  
                   NPC='Melaire/14'  Radius(Max)='1.7684925871354578(3.0)'  
                   Trigger text='Swiftness'  LOS='true'  Facing='true' 
06:06:52 [INFO]  Filled tag <npc.name.nickname> with 'Melaire'. 
06:06:52 [INFO]  Filled tag <player.name> with 'UrSubconscious'. 
06:06:52 [INFO]  Filled tag <npc.name.nickname> with 'Melaire'. 
06:06:52 [INFO] +- Parsing CHAT trigger: Melaire/UrSubconscious ---------+ 
06:06:52 [INFO] +- Executing dCommand: ENGAGE/UrSubconscious ---------+ 
06:06:52 [INFO] +> Executing 'ENGAGE': NPC='Melaire/14'  duration='300t' 
06:06:52 [INFO]  Starting TimedQueue 
                   'C9AA67B4-235C-46DF-B5B5-8724408AA0FB' 
06:06:52 [INFO] +> [WorldScriptH...] CHAT: UrSubconscious: Swiftness 
06:06:52 [INFO] +- Executing dCommand: IF/UrSubconscious ---------+ 
06:06:52 [INFO]  Filled tag <player.money> with '88935.31000000217'. 
06:06:52 [INFO]  Filled tag <PotionFee> with '50'. 
06:06:52 [INFO]  Comparable 1: Comparable='Double(88935.31000000217)', 
                   Operator='OR_MORE', ComparedTo='Integer(50)' --> 
                   OUTCOME='true' 
06:06:53 [INFO] +- Executing dCommand: RUNTASK/UrSubconscious ---------+ 
06:06:53 [INFO]  ERROR! While parsing 'script:Create Swiftness', Denizen 
                   has run into a problem. This argument's format is correct, 
                   but Denizen couldn't locate a script named 'Create 
                   Swiftness'. Is it spelled correctly? 
06:06:53 [INFO]  ERROR! Woah! Invalid arguments were specified! 
06:06:53 [INFO] +> [CommandExecuter] +> MESSAGE follows: 'Unknown argument 
                   'script:Create Swiftness'!' 
06:06:53 [INFO] +> [CommandExecuter] Usage: runtask [<name>] (instantly) 
                   (queue(:<name>)) (delay:<#>) (define:<element>|...) 
06:06:53 [INFO] +---------------------+ 
06:06:53 [INFO] +- Executing dCommand: DISENGAGE/UrSubconscious ---------+ 
06:06:53 [INFO] +> Executing 'DISENGAGE': NPC='Melaire/14' 
06:06:53 [INFO]  Completing queue C9AA67B4-235C-46DF-B5B5-8724408AA0FB...