Paste #50625: Denizen Debug Logs From 8Welcome to fEbs3o9t5edr7ifa 6v1.13!! 8oAdventure Awaits!

Date: 2018/11/07 15:56:12 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.8.0_172
Up-time: 6d 7h
CraftBukkit Version: git-Paper-413 (MC: 1.13.2)
Denizen Version: Core: 1.20 (Build 161), CraftBukkit: 1.0.3-SNAPSHOT (build 448-DEV)
Active Plugins (28): dynmap: 3.0-beta-2-138, WorldBorder: 1.8.7, ProtocolLib: 4.4.0-SNAPSHOT-b415, 
Multiverse-Core: 2.6.0-b738, LibsDisguises: 9.6.0-SNAPSHOT, MythicDrops: 4.3.2-3ba4261, 
FastAsyncWorldEdit: 1.0, PermissionsEx: 1.23.4, EffectLib: 6.2-SNAPSHOT, Vault: 1.6.7-b${env.TRAVIS_BUILD_NUMBER}, 
Essentials: 2.15.0.55, BKCommonLib: 1.13.2-v1-SNAPSHOT, LightCleaner: 1.13.1-v1, 
HolographicDisplays: 2.3.1-SNAPSHOT, Citizens: 2.0.24-SNAPSHOT (build 1590), 
EssentialsProtect: 2.15.0.55, EssentialsChat: 2.15.0.55, EssentialsGeoIP: 2.15.0.55, 
EssentialsAntiBuild: 2.15.0.55, EssentialsSpawn: 2.15.0.55, Denizen: 1.0.3-SNAPSHOT (build 448-DEV), 
WorldEdit: unspecified, WorldEditSelectionVisualizer: 1.6.0, FastAsyncVoxelSniper: 18.10.26-94d5028-2069, 
WorldGuard: 7.0.0-SNAPSHOT;0dc5781, Depenizen: 1.0.0 (build 420), Heroes: 1.9.0-SNAPSHOT-d89381d, 
MythicMobs: 4.5.0-SNAPSHOT
Loaded Worlds (6): map, map_nether, map_the_end, map_rainbow, map_dungeons, map_spawn
Online Players (1): [Deity] ~Jimmy(ImadKWafai)
Offline Players: 11
Mode: online

18:56:04 [INFO] +> Executing 'Action': Type='On CLICK'  NPC='n@140'  Container='FRONTFOLLYFARMSTANDASN(ASSIGNMENT)'  Player='ImadKWafai' 
18:56:04 [INFO] +- Building action 'On CLICK' for n@140 ---------+ 
18:56:04 [INFO]  Starting InstantQueue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada'... 
18:56:04 [INFO]  Queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' Executing: NARRATE "Theo<&co> Welcome friend, we got whatever ya need for 
                   field or table!" 
18:56:04 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
18:56:04 [INFO]  Filled tag <&co> with ':'. 
18:56:04 [INFO] +> Executing 'NARRATE': Narrating='Theo: Welcome friend, we got whatever ya need for field or table!'  
                   Targets='[p@ImadKWafai]' 
18:56:04 [INFO]  Queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' Executing: YAML "load:/Shops/FrontFollyShops.yml" "id:FrontFollyShops" 
18:56:04 [INFO] +- Executing dCommand: YAML/p@ImadKWafai ---------+ 
18:56:04 [INFO] +> Executing 'YAML': id='FrontFollyShops'  action='LOAD'  filename='/Shops/FrontFollyShops.yml'  value=''  
                   fix_formatting='false' 
18:56:04 [INFO]  Queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' Executing: WAIT "2" 
18:56:04 [INFO] +- Executing dCommand: WAIT/p@ImadKWafai ---------+ 
18:56:04 [INFO] +> Executing 'WAIT': queue='FRONTFOLLYFARMSTANDASN_ServingSampleCanada'  delay='d@2.0s' 
18:56:04 [INFO]  Forcing queue FRONTFOLLYFARMSTANDASN_ServingSampleCanada into a timed queue... 
18:56:04 [INFO]  Completing queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' in 9ms. 
18:56:04 [INFO]  Starting TimedQueue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada'... 
18:56:06 [INFO]  Queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' Executing: INVENTORY "open" "d:in@FrontFollyFarmStandInv" 
18:56:06 [INFO] +- Executing dCommand: INVENTORY/p@ImadKWafai ---------+ 
18:56:06 [INFO]  Starting InstantQueue 'INV_SCRIPT_ITEM_PROC_ChoosingMusclesConservation'... 
18:56:06 [INFO]  Queue 'INV_SCRIPT_ITEM_PROC_ChoosingMusclesConservation' Executing: DETERMINE "<yaml[FrontFollyShops].read[Farmstand]>" 
18:56:06 [INFO] +- Executing dCommand: DETERMINE/p@ImadKWafai ---------+ 
18:56:06 [INFO]  Filled tag <yaml[FrontFollyShops].read[Farmstand]> with 'li@i@wheat_seeds[lore=Click Here to Buy&exc Cost&co 
                   $1;nbt=li@cost/1]|i@wheat_seeds[lore=Click Here to Buy&exc Cost&co $50;nbt=li@cost/50;quantity=64]|i@pumpkin_seeds[lore=Click 
                   Here to Buy&exc Cost&co $2;nbt=li@cost/2]|i@pumpkin_seeds[lore=Click Here to Buy&exc Cost&co 
                   $100;nbt=li@cost/100;quantity=64]|i@melon_seeds[lore=Click Here to Buy&exc Cost&co $2;nbt=li@cost/2]|i@melon_seeds[lore=Click 
                   Here to Buy&exc Cost&co $100;nbt=li@cost/100;quantity=64]|i@beetroot_seeds[lore=Click Here to Buy&exc Cost&co 
                   $1;nbt=li@cost/1]|i@beetroot_seeds[lore=Click Here to Buy&exc Cost&co $50;nbt=li@cost/50;quantity=64]|i@carrot[lore=Click Here 
                   to Buy&exc Cost&co $2;nbt=li@cost/2]|i@wheat[lore=Click Here to Buy&exc Cost&co $2;nbt=li@cost/2]|i@wheat[lore=Click Here to 
                   Buy&exc Cost&co $70;nbt=li@cost/70;quantity=64]|i@pumpkin[lore=Click Here to Buy&exc Cost&co 
                   $5;nbt=li@cost/5]|i@pumpkin[lore=Click Here to Buy&exc Cost&co $150;nbt=li@cost/150;quantity=64]|i@melon[l... * snip! * 
18:56:06 [INFO] +> Executing 'DETERMINE': outcome='li@i@wheat_seeds[lore=Click Here to Buy&exc Cost&co 
                   $1;nbt=li@cost/1]|i@wheat_seeds[lore=Click Here to Buy&exc Cost&co $50;nbt=li@cost/50;quantity=64]|i@pumpkin_seeds[lore=Click 
                   Here to Buy&exc Cost&co $2;nbt=li@cost/2]|i@pumpkin_seeds[lore=Click Here to Buy&exc Cost&co 
                   $100;nbt=li@cost/100;quantity=64]|i@melon_seeds[lore=Click Here to Buy&exc Cost&co $2;nbt=li@cost/2]|i@melon_seeds[lore=Click 
                   Here to Buy&exc Cost&co $100;nbt=li@cost/100;quantity=64]|i@beetroot_seeds[lore=Click Here to Buy&exc Cost&co 
                   $1;nbt=li@cost/1]|i@beetroot_seeds[lore=Click Here to Buy&exc Cost&co $50;nbt=li@cost/50;quantity=64]|i@carrot[lore=Click Here 
                   to Buy&exc Cost&co $2;nbt=li@cost/2]|i@wheat[lore=Click Here to Buy&exc Cost&co $2;nbt=li@cost/2]|i@wheat[lore=Click Here to 
                   Buy&exc Cost&co $70;nbt=li@cost/70;quantity=64]|i@pumpkin[lore=Click Here to Buy&exc Cost&co 
                   $5;nbt=li@cost/5]|i@pumpkin[lore=Click Here to Buy&exc Cost&co $150;nbt=li@cost/150;quantity=64]|i@melon[lore=Click Here to 
                   Buy&exc Cost&co $5;nbt=li@cost/5]|i... * snip! * 
18:56:06 [INFO]  Completing queue 'INV_SCRIPT_ITEM_PROC_ChoosingMusclesConservation' in 0ms. 
18:56:06 [INFO] +> Executing 'INVENTORY': actions='[open]'  Inventory='in@FRONTFOLLYFARMSTANDINV'  slot='1' 
18:56:06 [INFO]  Queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' Executing: YAML "unload" "id:FrontFollyShops" 
18:56:06 [INFO] +- Executing dCommand: YAML/p@ImadKWafai ---------+ 
18:56:06 [INFO] +> Executing 'YAML': id='FrontFollyShops'  action='UNLOAD'  value=''  fix_formatting='false' 
18:56:06 [INFO]  Completing queue 'FRONTFOLLYFARMSTANDASN_ServingSampleCanada' in 2039ms. 
18:56:07 [INFO] +> Executing 'Event': Type='on player clicks in FRONTFOLLYFARMSTANDINV'  Container='FRONTFOLLYFARMSTANDHANDLER(WORLD)'  
                   player=p@ImadKWafaiContext='{item=i@wheat_seeds[lore=Click Here to Buy&exc Cost&co $1;nbt=li@cost/1], cursor_item=i@air, 
                   raw_slot=1, is_shift_click=false, slot_type=CONTAINER, action=PICKUP_ALL, slot=1, inventory=in@FRONTFOLLYFARMSTANDINV, 
                   click=LEFT, hotbar_button=0}' 
18:56:07 [INFO] +- Building event 'ON PLAYER CLICKS IN FRONTFOLLYFARMSTANDINV' for FRONTFOLLYFARMSTANDHANDLER ---------+ 
18:56:07 [INFO]  Starting InstantQueue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting'... 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: DETERMINE "passively" "cancelled" 
18:56:07 [INFO] +- Executing dCommand: DETERMINE/p@ImadKWafai ---------+ 
18:56:07 [INFO] +> Executing 'DETERMINE': outcome='cancelled'  passively='true' 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: IF "<context.item.has_nbt[Cost]>" "{" "-" "if" 
                   "<player.money.is[MORE].to[<context.item.nbt[Cost]>]>" "{" "-" "if" "<player.inventory.is_full>" "{" "-" "narrate" "Your 
                   inventory is full!" "-" "queue" "clear" "}" "-" "take" "money" "quantity:<context.item.nbt[Cost]>" "-" "adjust" 
                   "<context.item>" "Lore:<context.item.lore.remove[<context.cursor_item.lore.size>]>" "save:Item" "-" "nbt" 
                   "<entry[Cost].result>" "Cost:!" "save:Item" "-" "give" "<entry[Item].new_item>" "-" "narrate" "$<context.item.nbt[Cost]> has 
                   been removed from your wallet." "-" "flag" "player" "TotalSpent:+:<context.item.nbt[Cost]>" "-" "queue" "clear" "}" "else" "{" 
                   "-" "narrate" "You don't have enough money! Cost<&co> $<context.item.nbt[Cost]> Your Money<&co> $<player.money>" "-" "queue" 
                   "clear" "}" "}" 
18:56:07 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
18:56:07 [INFO] +> Executing 'IF': use_braces='true' 
18:56:07 [INFO]  Filled tag <context.item.has_nbt[Cost]> with 'true'. 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: IF 
                   "<player.money.is[MORE].to[<context.item.nbt[Cost]>]>" "{" "-" "if" "<player.inventory.is_full>" "{" "-" "narrate" "Your 
                   inventory is full!" "-" "queue" "clear" "}" "-" "take" "money" "quantity:<context.item.nbt[Cost]>" "-" "adjust" 
                   "<context.item>" "Lore:<context.item.lore.remove[<context.cursor_item.lore.size>]>" "save:Item" "-" "nbt" 
                   "<entry[Cost].result>" "Cost:!" "save:Item" "-" "give" "<entry[Item].new_item>" "-" "narrate" "$<context.item.nbt[Cost]> has 
                   been removed from your wallet." "-" "flag" "player" "TotalSpent:+:<context.item.nbt[Cost]>" "-" "queue" "clear" "}" "else" "{" 
                   "-" "narrate" "You don't have enough money! Cost<&co> $<context.item.nbt[Cost]> Your Money<&co> $<player.money>" "-" "queue" 
                   "clear" "}" 
18:56:07 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
18:56:07 [INFO] +> Executing 'IF': use_braces='true' 
18:56:07 [INFO]  Filled tag <context.item.nbt[Cost]> with '1'. 
18:56:07 [INFO]  Filled tag <player.money.is[MORE].to[1]> with 'true'. 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: IF "<player.inventory.is_full>" "{" "-" "narrate" 
                   "Your inventory is full!" "-" "queue" "clear" "}" 
18:56:07 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
18:56:07 [INFO] +> Executing 'IF': use_braces='true' 
18:56:07 [INFO]  Filled tag <player.inventory.is_full> with 'false'. 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: TAKE "money" "quantity:<context.item.nbt[Cost]>" 
18:56:07 [INFO] +- Executing dCommand: TAKE/p@ImadKWafai ---------+ 
18:56:07 [INFO]  Filled tag <context.item.nbt[Cost]> with '1'. 
18:56:07 [INFO] +> Executing 'TAKE': Type='MONEY'  qty='1'  Items='null' 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: ADJUST "<context.item>" 
                   "Lore:<context.item.lore.remove[<context.cursor_item.lore.size>]>" 
18:56:07 [INFO] +- Executing dCommand: ADJUST/p@ImadKWafai ---------+ 
18:56:07 [INFO]  ...remembering this script entry as 'Item'! 
18:56:07 [INFO]  Filled tag <context.item> with 'i@wheat_seeds[lore=Click Here to Buy&exc Cost&co $1;nbt=li@cost/1]'. 
18:56:07 [INFO]  Unfilled attributes 'lore.size' for tag <context.cursor_item.lore.size>! 
18:56:07 [INFO]  Filled tag <context.cursor_item.lore.size> with 'null'. 
18:56:07 [INFO]  ERROR in script 'FRONTFOLLYFARMSTANDHANDLER'! Tag <context.cursor_item.lore.size> is invalid! 
18:56:07 [INFO]  ERROR in script 'FRONTFOLLYFARMSTANDHANDLER'! 'context.cursor_item.lore.size' is not a valid integer! 
18:56:07 [INFO]  Filled tag <context.item.lore.remove[context.cursor_item.lore.size]> with 'li@Click Here to Buy! Cost: $1'. 
18:56:07 [INFO] +> Executing 'ADJUST': object='li@i@wheat_seeds[lore=Click Here to Buy&exc Cost&co $1;nbt=li@cost/1]'  mechanism='Lore'  
                   mechanism_value='li@Click Here to Buy! Cost: $1' 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: NBT "<entry[Cost].result>" "Cost:!" 
18:56:07 [INFO] +- Executing dCommand: NBT/p@ImadKWafai ---------+ 
18:56:07 [INFO]  ...remembering this script entry as 'Item'! 
18:56:07 [INFO]  Bad saved entry ID 'Cost' 
18:56:07 [INFO]  Filled tag <entry[Cost].result> with 'entry[Cost].result'. 
18:56:07 [INFO]  ERROR in script 'FRONTFOLLYFARMSTANDHANDLER'! Tag <entry[Cost].result> is invalid! 
18:56:07 [INFO]  ERROR in script 'FRONTFOLLYFARMSTANDHANDLER'! 'entry[Cost].result' is an unknown argument! 
18:56:07 [INFO]  ERROR in script 'FRONTFOLLYFARMSTANDHANDLER'! Woah! Invalid arguments were specified! 
18:56:07 [INFO] +> [Denizen] +> MESSAGE follows: 'Must specify item!' 
18:56:07 [INFO] +> [Denizen] Usage: nbt [<item>] [<key>:<value>] 
18:56:07 [INFO] +> [Denizen] (Attempted: NBT "<entry[Cost].result>" "Cost:!" "save:Item") 
18:56:07 [INFO] +---------------------+ 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: GIVE "<entry[Item].new_item>" 
18:56:07 [INFO] +- Executing dCommand: GIVE/p@ImadKWafai ---------+ 
18:56:07 [INFO]  Missing saved entry object 'new_item' 
18:56:07 [INFO]  Filled tag <entry[Item].new_item> with 'entry[Item].new_item'. 
18:56:07 [INFO]  ERROR in script 'FRONTFOLLYFARMSTANDHANDLER'! Tag <entry[Item].new_item> is invalid! 
18:56:07 [INFO] +> Executing 'GIVE': Type='ITEM'  inventory='in@player[holder=p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b]'  Quantity='1.0'  
                   engrave='false'  unlimit_stack_size='false'  Items='[]'  slot='1' 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: NARRATE "$<context.item.nbt[Cost]> has been removed 
                   from your wallet." 
18:56:07 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
18:56:07 [INFO]  Filled tag <context.item.nbt[Cost]> with '1'. 
18:56:07 [INFO] +> Executing 'NARRATE': Narrating='$1 has been removed from your wallet.'  Targets='[p@ImadKWafai]' 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: FLAG "player" "TotalSpent:+:<context.item.nbt[Cost]>" 
18:56:07 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
18:56:07 [INFO]  Filled tag <context.item.nbt[Cost]> with '1'. 
18:56:07 [INFO] +> Executing 'FLAG': flag_name='TOTALSPENT'  Action/Value='INCREASE(1)'  flag_target='p@ImadKWafai' 
18:56:07 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' Executing: QUEUE "clear" 
18:56:07 [INFO] +- Executing dCommand: QUEUE/p@ImadKWafai ---------+ 
18:56:07 [INFO] +> Executing 'QUEUE': queue='q@FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting'  Action='CLEAR' 
18:56:07 [INFO]  Completing queue 'FRONTFOLLYFARMSTANDHANDLER_LoggedProtectionKnitting' in 7ms. 
18:56:08 [INFO]  Running script event 'PlayerClosesInv', event='player closes FrontFollyFarmStandInv' for script 'FRONTFOLLYFARMSTANDHANDLER' 
18:56:08 [INFO]  Starting InstantQueue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant'... 
18:56:08 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant' Executing: IF "<player.has_flag[TotalSpent]>" "{" "-" "narrate" 
                   "Theo<&co> Thank you for yer patronage. Y'all c'mon back now!" "-" "narrate" "Total Spent<&co> $<player.flag[TotalSpent]> 
                   Current Balance<&co> $<player.money>" "-" "flag" "player" "TotalSpent:!" "-" "queue" "clear" "}" "else" "{" "-" "narrate" 
                   "Theo<&co> I got a business to run man, step aside for someone who's gonna spend some money!" "-" "queue" "clear" "}" 
18:56:08 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
18:56:08 [INFO] +> Executing 'IF': use_braces='true' 
18:56:08 [INFO]  Filled tag <player.has_flag[TotalSpent]> with 'true'. 
18:56:08 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant' Executing: NARRATE "Theo<&co> Thank you for yer patronage. Y'all c'mon 
                   back now!" 
18:56:08 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
18:56:08 [INFO]  Filled tag <&co> with ':'. 
18:56:08 [INFO] +> Executing 'NARRATE': Narrating='Theo: Thank you for yer patronage. Y'all c'mon back now!'  Targets='[p@ImadKWafai]' 
18:56:08 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant' Executing: NARRATE "Total Spent<&co> $<player.flag[TotalSpent]> 
                   Current Balance<&co> $<player.money>" 
18:56:08 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
18:56:08 [INFO]  Filled tag <&co> with ':'. 
18:56:08 [INFO]  Filled tag <player.flag[TotalSpent]> with '1'. 
18:56:08 [INFO]  Filled tag <&co> with ':'. 
18:56:08 [INFO]  Filled tag <player.money> with '15401'. 
18:56:08 [INFO] +> Executing 'NARRATE': Narrating='Total Spent: $1 Current Balance: $15401'  Targets='[p@ImadKWafai]' 
18:56:08 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant' Executing: FLAG "player" "TotalSpent:!" 
18:56:08 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
18:56:08 [INFO] +> Executing 'FLAG': flag_name='TOTALSPENT'  Action/Value='DELETE(false)'  flag_target='p@ImadKWafai' 
18:56:08 [INFO]  Queue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant' Executing: QUEUE "clear" 
18:56:08 [INFO] +- Executing dCommand: QUEUE/p@ImadKWafai ---------+ 
18:56:08 [INFO] +> Executing 'QUEUE': queue='q@FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant'  Action='CLEAR' 
18:56:08 [INFO]  Completing queue 'FRONTFOLLYFARMSTANDHANDLER_FamilyPlazaMerchant' in 2ms.