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

Date: 2018/11/17 10:22:35 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.8.0_192
Up-time: 3h 39m
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 (26): dynmap: 3.0-beta-2-138, ProtocolLib: 4.4.0-SNAPSHOT-b415, Multiverse-Core: 2.6.0-b738, 
LibsDisguises: 9.6.0-SNAPSHOT, MythicDrops: 4.3.2-3ba4261, 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), FastAsyncWorldEdit: 1.0, WorldEdit: unspecified, 
FastAsyncVoxelSniper: 18.11.14-ec22c4f-2071, 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_spawn, map_dungeons
Online Players (1): [Deity] ~Jimmy(ImadKWafai)
Offline Players: 12
Mode: online

13:22:25 [INFO] +> Executing 'Action': Type='On CLICK'  NPC='n@16'  Container='RAYLINASN(ASSIGNMENT)'  Player='ImadKWafai' 
13:22:25 [INFO] +- Building action 'On CLICK' for n@16 ---------+ 
13:22:25 [INFO]  Starting InstantQueue 'RAYLINASN_CatholicBelizeJets'... 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: NARRATE "Raylin<&co> Take a look at our wears. Various armorment to keep you 
                   safe!" 
13:22:25 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
13:22:25 [INFO]  Filled tag <&co> with ':'. 
13:22:25 [INFO] +> Executing 'NARRATE': Narrating='Raylin: Take a look at our wears. Various armorment to keep you safe!'  
                   Targets='[p@ImadKWafai]' 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.repairable>" "{" "-" "if" 
                   "<player.item_in_hand.durability.is[MORE].to[0]>" "{" "-" "flag" "player" "repaircost:<player.item_in_hand.durability.mul[2]>" 
                   "}" "else" "{" "-" "flag" "player" "repaircost:0" "}" "-" "if" "<player.item_in_hand.has_lore>" "{" "-" "foreach" 
                   "<player.item_in_hand.lore>" "{" "-" "if" "<def[value].has_nbt[Socket]>" "{" "-" "flag" "player" "SocketCost:NA" "-" "wait" 
                   "1" "-" "flag" "player" "Smitty:Armor" "-" "yaml" "load:/Shops/FrontFollyShops.yml" "id:FrontFollyShops" "-" "inventory" 
                   "open" "d:in@SmittysSmithyInv" "-" "queue" "clear" "}" "}" "}" "-" "if" "<player.item_in_hand.material.contains[Stone]>" "{" 
                   "-" "flag" "player" "SocketCost:750" "}" "-" "if" "<player.item_in_hand.material.contains[Wooden]>" "{" "-" "flag" "player" 
                   "SocketCost:500" "}" "-" "if" "<player.item_in_hand.material.contains[Iron]>" "{" "-" "flag" "player" "SocketCost:2000" "}" 
                   "-" "if" "<player.item_in_hand.material.contains[Golden]>" "{" ... * snip! * 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.repairable> with 'true'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.durability.is[MORE].to[0]>" "{" "-" "flag" "player" 
                   "repaircost:<player.item_in_hand.durability.mul[2]>" "}" "else" "{" "-" "flag" "player" "repaircost:0" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.durability.is[MORE].to[0]> with 'false'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: FLAG "player" "repaircost:0" 
13:22:25 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'FLAG': flag_name='REPAIRCOST'  Action/Value='SET_VALUE(0)'  flag_target='p@ImadKWafai' 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.has_lore>" "{" "-" "foreach" 
                   "<player.item_in_hand.lore>" "{" "-" "if" "<def[value].has_nbt[Socket]>" "{" "-" "flag" "player" "SocketCost:NA" "-" "wait" 
                   "1" "-" "flag" "player" "Smitty:Armor" "-" "yaml" "load:/Shops/FrontFollyShops.yml" "id:FrontFollyShops" "-" "inventory" 
                   "open" "d:in@SmittysSmithyInv" "-" "queue" "clear" "}" "}" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.has_lore> with 'false'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.material.contains[Stone]>" "{" "-" "flag" "player" 
                   "SocketCost:750" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.material.contains[Stone]> with 'false'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.material.contains[Wooden]>" "{" "-" "flag" "player" 
                   "SocketCost:500" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.material.contains[Wooden]> with 'true'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: FLAG "player" "SocketCost:500" 
13:22:25 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'FLAG': flag_name='SOCKETCOST'  Action/Value='SET_VALUE(500)'  flag_target='p@ImadKWafai' 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.material.contains[Iron]>" "{" "-" "flag" "player" 
                   "SocketCost:2000" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.material.contains[Iron]> with 'false'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.material.contains[Golden]>" "{" "-" "flag" "player" 
                   "SocketCost:3500" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.material.contains[Golden]> with 'false'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: IF "<player.item_in_hand.material.contains[Diamond]>" "{" "-" "flag" "player" 
                   "SocketCost:7500" "}" 
13:22:25 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'IF': use_braces='true' 
13:22:25 [INFO]  Filled tag <player.item_in_hand.material.contains[Diamond]> with 'false'. 
13:22:25 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: WAIT "1" 
13:22:25 [INFO] +- Executing dCommand: WAIT/p@ImadKWafai ---------+ 
13:22:25 [INFO] +> Executing 'WAIT': queue='RAYLINASN_CatholicBelizeJets'  delay='d@1.0s' 
13:22:25 [INFO]  Forcing queue RAYLINASN_CatholicBelizeJets into a timed queue... 
13:22:25 [INFO]  Completing queue 'RAYLINASN_CatholicBelizeJets' in 4ms. 
13:22:25 [INFO]  Starting TimedQueue 'RAYLINASN_CatholicBelizeJets'... 
13:22:27 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: FLAG "player" "Smitty:Armor" 
13:22:27 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
13:22:27 [INFO] +> Executing 'FLAG': flag_name='SMITTY'  Action/Value='SET_VALUE(Armor)'  flag_target='p@ImadKWafai' 
13:22:27 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: YAML "load:/Shops/FrontFollyShops.yml" "id:FrontFollyShops" 
13:22:27 [INFO] +- Executing dCommand: YAML/p@ImadKWafai ---------+ 
13:22:27 [INFO] +> Executing 'YAML': id='FrontFollyShops'  action='LOAD'  filename='/Shops/FrontFollyShops.yml'  value=''  
                   fix_formatting='false' 
13:22:27 [INFO]  Queue 'RAYLINASN_CatholicBelizeJets' Executing: INVENTORY "open" "d:in@SmittysSmithyInv" 
13:22:27 [INFO] +- Executing dCommand: INVENTORY/p@ImadKWafai ---------+ 
13:22:27 [INFO]  Filled tag <&co> with ':'. 
13:22:27 [INFO]  Filled tag <player.flag[repaircost]> with '0'. 
13:22:27 [INFO]  Filled tag <&co> with ':'. 
13:22:27 [INFO]  Filled tag <player.flag[SocketCost]> with '500'. 
13:22:27 [INFO]  Starting InstantQueue 'INV_SCRIPT_ITEM_PROC_IngNewsletterCholesterol'... 
13:22:27 [INFO]  Queue 'INV_SCRIPT_ITEM_PROC_IngNewsletterCholesterol' Executing: IF "<player.flag[Smitty].is[==].to[Armor]>" "{" "-" 
                   "determine" "<yaml[FrontFollyShops].read[SmittyArmor].insert[i@SmittyArmsIt|i@SmittyToolsIt].at[44]>" "}" 
13:22:27 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:27 [INFO] +> Executing 'IF': use_braces='true' 
13:22:27 [INFO]  Filled tag <player.flag[Smitty].is[==].to[Armor]> with 'true'. 
13:22:27 [INFO]  Queue 'INV_SCRIPT_ITEM_PROC_IngNewsletterCholesterol' Executing: DETERMINE 
                   "<yaml[FrontFollyShops].read[SmittyArmor].insert[i@SmittyArmsIt|i@SmittyToolsIt].at[44]>" 
13:22:27 [INFO] +- Executing dCommand: DETERMINE/p@ImadKWafai ---------+ 
13:22:27 [INFO]  Filled tag <yaml[FrontFollyShops].read[SmittyArmor].insert[i@SmittyArmsIt|i@SmittyToolsIt].at[44]> with 
                   'li@i@diamond_chestplate[lore=Click Here to Buy&exc Cost&co $2550;nbt=li@cost/2550]|i@diamond_helmet[lore=Click Here to 
                   Buy&exc Cost&co $1500;nbt=li@cost/1500]|i@diamond_leggings[lore=Click Here to Buy&exc Cost&co 
                   $2000;nbt=li@cost/2000]|i@diamond_boots[lore=Click Here to Buy&exc Cost&co 
                   $1500;nbt=li@cost/1500]|i@golden_chestplate[lore=Click Here to Buy&exc Cost&co 
                   $1000;nbt=li@cost/1000]|i@golden_helmet[lore=Click Here to Buy&exc Cost&co $700;nbt=li@cost/700]|i@golden_leggings[lore=Click 
                   Here to Buy&exc Cost&co $750;nbt=li@cost/750]|i@golden_boots[lore=Click Here to Buy&exc Cost&co 
                   $700;nbt=li@cost/700]|i@shield[lore=Click Here to Buy&exc Cost&co $200;nbt=li@cost/200]|i@iron_chestplate[lore=Click Here to 
                   Buy&exc Cost&co $450;nbt=li@cost/450]|i@iron_helmet[lore=Click Here to Buy&exc Cost&co 
                   $200;nbt=li@cost/200]|i@iron_leggings[lore=Click Here to Buy&exc Cost&co $350;nbt=li@cost/350]|i@iron_boots[l... * snip! * 
13:22:27 [INFO] +> Executing 'DETERMINE': outcome='li@i@diamond_chestplate[lore=Click Here to Buy&exc Cost&co 
                   $2550;nbt=li@cost/2550]|i@diamond_helmet[lore=Click Here to Buy&exc Cost&co 
                   $1500;nbt=li@cost/1500]|i@diamond_leggings[lore=Click Here to Buy&exc Cost&co 
                   $2000;nbt=li@cost/2000]|i@diamond_boots[lore=Click Here to Buy&exc Cost&co 
                   $1500;nbt=li@cost/1500]|i@golden_chestplate[lore=Click Here to Buy&exc Cost&co 
                   $1000;nbt=li@cost/1000]|i@golden_helmet[lore=Click Here to Buy&exc Cost&co $700;nbt=li@cost/700]|i@golden_leggings[lore=Click 
                   Here to Buy&exc Cost&co $750;nbt=li@cost/750]|i@golden_boots[lore=Click Here to Buy&exc Cost&co 
                   $700;nbt=li@cost/700]|i@shield[lore=Click Here to Buy&exc Cost&co $200;nbt=li@cost/200]|i@iron_chestplate[lore=Click Here to 
                   Buy&exc Cost&co $450;nbt=li@cost/450]|i@iron_helmet[lore=Click Here to Buy&exc Cost&co 
                   $200;nbt=li@cost/200]|i@iron_leggings[lore=Click Here to Buy&exc Cost&co $350;nbt=li@cost/350]|i@iron_boots[lore=Click Here to 
                   Buy&exc Cost&co $300;nbt=li@cost/300]|i@air|i@air|i@air|i@air|i@air|i@air|i@air|i@a... * snip! * 
13:22:27 [INFO]  Completing queue 'INV_SCRIPT_ITEM_PROC_IngNewsletterCholesterol' in 1ms. 
13:22:27 [INFO] +> Executing 'INVENTORY': actions='[open]'  Inventory='in@SMITTYSSMITHYINV'  slot='1' 
13:22:27 [INFO]  Completing queue 'RAYLINASN_CatholicBelizeJets' in 1050ms. 
13:22:29 [INFO] +> Executing 'Event': Type='on player clicks in SMITTYSSMITHYINV'  Container='SMITTYSSMITHYHANDLER(WORLD)'  
                   player=p@ImadKWafaiContext='{item=i@ADDSOCKETIT[display_name=Add A Socket;lore=Click here to add a Socket to the item in your 
                   hand&dot|Sockets can be fitted with Socket Gems to make items|more powerful&dot|Cost&co $500], cursor_item=i@air, raw_slot=43, 
                   is_shift_click=false, slot_type=CONTAINER, action=PICKUP_ALL, slot=43, inventory=in@SMITTYSSMITHYINV, click=LEFT, 
                   hotbar_button=0}' 
13:22:29 [INFO] +- Building event 'ON PLAYER CLICKS IN SMITTYSSMITHYINV' for SMITTYSSMITHYHANDLER ---------+ 
13:22:29 [INFO]  Starting InstantQueue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries'... 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: DETERMINE "passively" "cancelled" 
13:22:29 [INFO] +- Executing dCommand: DETERMINE/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'DETERMINE': outcome='cancelled'  passively='true' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: IF "<context.item.simple.is[==].to[i@AddSocketIt]>" "{" "-" 
                   "if" "<player.item_in_hand.repairable.not>" "{" "-" "inventory" "close" "-" "narrate" "Raylin<&co> I'm sorry, but we can't add 
                   a socket to that kind of item. This is a smithy afterall! (Sockets can only be added to weapons, armor and tools at this 
                   shop.)" "-" "queue" "clear" "}" "-" "if" "<player.flag[SocketCost].is[==].to[NA]>" "{" "-" "inventory" "close" "-" "narrate" 
                   "Raylin<&co> I'm sorry, but that item can't handle anymore sockets!" "-" "queue" "clear" "}" "else" "{" "-" "if" 
                   "<player.money.is[MORE].to[<player.flag[SocketCost]>]>" "{" "-" "take" "money" "quantity:<player.flag[SocketCost]>" "-" 
                   "inventory" "close" "-" "narrate" "Raylin<&co> Let me take this out back to Smitty. This could take a little while." "-" 
                   "cast" "BLINDNESS" "<player>" "d:5s" "-" "playsound" "<player>" "sound:BLOCK_ANVIL_USE" "-" "if" 
                   "<player.item_in_hand.has_lore>" "{" "-" "adjust" "<player.item_in_hand>" "... * snip! * 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <context.item.simple.is[==].to[i@AddSocketIt]> with 'true'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: IF "<player.item_in_hand.repairable.not>" "{" "-" "inventory" 
                   "close" "-" "narrate" "Raylin<&co> I'm sorry, but we can't add a socket to that kind of item. This is a smithy afterall! 
                   (Sockets can only be added to weapons, armor and tools at this shop.)" "-" "queue" "clear" "}" 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <player.item_in_hand.repairable.not> with 'false'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: IF "<player.flag[SocketCost].is[==].to[NA]>" "{" "-" 
                   "inventory" "close" "-" "narrate" "Raylin<&co> I'm sorry, but that item can't handle anymore sockets!" "-" "queue" "clear" "}" 
                   "else" "{" "-" "if" "<player.money.is[MORE].to[<player.flag[SocketCost]>]>" "{" "-" "take" "money" 
                   "quantity:<player.flag[SocketCost]>" "-" "inventory" "close" "-" "narrate" "Raylin<&co> Let me take this out back to Smitty. 
                   This could take a little while." "-" "cast" "BLINDNESS" "<player>" "d:5s" "-" "playsound" "<player>" "sound:BLOCK_ANVIL_USE" 
                   "-" "if" "<player.item_in_hand.has_lore>" "{" "-" "adjust" "<player.item_in_hand>" 
                   "lore:<player.item_in_hand.lore.include[<&r>(Socket)]>" "save:item" "}" "else" "{" "-" "adjust" "<player.item_in_hand>" 
                   "lore:<&r>(Socket)" "save:item" "}" "-" "adjust" "<entry[item].result>" "nbt:Socket" "save:item" "-" "adjust" "<player>" 
                   "item_in_hand:<entry[item].new_item>" "-" "wait" "3" "-" "narrate" "Raylin<&co> There you go, choose wisel... * snip! * 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <player.flag[SocketCost].is[==].to[NA]> with 'false'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: IF "<player.money.is[MORE].to[<player.flag[SocketCost]>]>" "{" 
                   "-" "take" "money" "quantity:<player.flag[SocketCost]>" "-" "inventory" "close" "-" "narrate" "Raylin<&co> Let me take this 
                   out back to Smitty. This could take a little while." "-" "cast" "BLINDNESS" "<player>" "d:5s" "-" "playsound" "<player>" 
                   "sound:BLOCK_ANVIL_USE" "-" "if" "<player.item_in_hand.has_lore>" "{" "-" "adjust" "<player.item_in_hand>" 
                   "lore:<player.item_in_hand.lore.include[<&r>(Socket)]>" "save:item" "}" "else" "{" "-" "adjust" "<player.item_in_hand>" 
                   "lore:<&r>(Socket)" "save:item" "}" "-" "adjust" "<entry[item].result>" "nbt:Socket" "save:item" "-" "adjust" "<player>" 
                   "item_in_hand:<entry[item].new_item>" "-" "wait" "3" "-" "narrate" "Raylin<&co> There you go, choose wisely when adding a 
                   gem!" "-" "queue" "clear" "}" "else" "{" "-" "narrate" "You don't have enough money! Cost<&co> $<player.flag[SocketCost]> Your 
                   Money:<player.money>" "-" "queue" "clear" "}" 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <player.flag[SocketCost]> with '500'. 
13:22:29 [INFO]  Filled tag <player.money.is[MORE].to[500]> with 'true'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: TAKE "money" "quantity:<player.flag[SocketCost]>" 
13:22:29 [INFO] +- Executing dCommand: TAKE/p@ImadKWafai ---------+ 
13:22:29 [INFO]  Filled tag <player.flag[SocketCost]> with '500'. 
13:22:29 [INFO] +> Executing 'TAKE': Type='MONEY'  qty='500'  Items='null' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: INVENTORY "close" 
13:22:29 [INFO] +- Executing dCommand: INVENTORY/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'INVENTORY': actions='[close]'  Inventory='in@player[holder=p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b]'  slot='1' 
13:22:29 [INFO]  Running script event 'PlayerClosesInv', event='player closes SmittysSmithyInv' for script 'SMITTYSSMITHYHANDLER' 
13:22:29 [INFO]  Starting InstantQueue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped'... 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: IF "<player.has_flag[StillShopping]>" "{" "-" "queue" 
                   "clear" "}" 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <player.has_flag[StillShopping]> with 'false'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: YAML "unload" "id:FrontFollyShops" 
13:22:29 [INFO] +- Executing dCommand: YAML/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'YAML': id='FrontFollyShops'  action='UNLOAD'  value=''  fix_formatting='false' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: IF "<player.has_flag[TotalSpent]>" "{" "-" "narrate" 
                   "Raylin<&co> Thank you sir! Come back for all your smithy needs!" "-" "narrate" "Total Spent<&co> $<player.flag[TotalSpent]> 
                   Current Balance<&co> $<player.money>" "-" "flag" "player" "TotalSpent:!" "-" "flag" "player" "Smitty:!" "-" "flag" "player" 
                   "repaircost:!" "-" "flag" "player" "SocketCost:!" "-" "queue" "clear" "}" "else" "{" "-" "flag" "player" "Smitty:!" "-" "flag" 
                   "player" "repaircost:!" "-" "flag" "player" "SocketCost:!" "-" "narrate" "Raylin<&co> Feel free to browse." "-" "queue" 
                   "clear" "}" 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <player.has_flag[TotalSpent]> with 'false'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: FLAG "player" "Smitty:!" 
13:22:29 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'FLAG': flag_name='SMITTY'  Action/Value='DELETE(false)'  flag_target='p@ImadKWafai' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: FLAG "player" "repaircost:!" 
13:22:29 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'FLAG': flag_name='REPAIRCOST'  Action/Value='DELETE(false)'  flag_target='p@ImadKWafai' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: FLAG "player" "SocketCost:!" 
13:22:29 [INFO] +- Executing dCommand: FLAG/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'FLAG': flag_name='SOCKETCOST'  Action/Value='DELETE(false)'  flag_target='p@ImadKWafai' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: NARRATE "Raylin<&co> Feel free to browse." 
13:22:29 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
13:22:29 [INFO]  Filled tag <&co> with ':'. 
13:22:29 [INFO] +> Executing 'NARRATE': Narrating='Raylin: Feel free to browse.'  Targets='[p@ImadKWafai]' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' Executing: QUEUE "clear" 
13:22:29 [INFO] +- Executing dCommand: QUEUE/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'QUEUE': queue='q@SMITTYSSMITHYHANDLER_RaisedLightweightShipped'  Action='CLEAR' 
13:22:29 [INFO]  Completing queue 'SMITTYSSMITHYHANDLER_RaisedLightweightShipped' in 2ms. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: NARRATE "Raylin<&co> Let me take this out back to Smitty. This 
                   could take a little while." 
13:22:29 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
13:22:29 [INFO]  Filled tag <&co> with ':'. 
13:22:29 [INFO] +> Executing 'NARRATE': Narrating='Raylin: Let me take this out back to Smitty. This could take a little while.'  
                   Targets='[p@ImadKWafai]' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: CAST "BLINDNESS" "<player>" "d:5s" 
13:22:29 [INFO] +- Executing dCommand: CAST/p@ImadKWafai ---------+ 
13:22:29 [INFO]  Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'. 
13:22:29 [INFO] +> Executing 'CAST': Target(s)='[p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b]'  Effect='BLINDNESS'  Amplifier='1'  
                   duration='d@5.0s'  ambient='true'  show_particles='true' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: PLAYSOUND "<player>" "sound:BLOCK_ANVIL_USE" 
13:22:29 [INFO] +- Executing dCommand: PLAYSOUND/p@ImadKWafai ---------+ 
13:22:29 [INFO]  Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'. 
13:22:29 [INFO] +> Executing 'PLAYSOUND': entities='[p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b]'  sound='BLOCK_ANVIL_USE'  volume='1'  pitch='1'  
                   custom='false' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: IF "<player.item_in_hand.has_lore>" "{" "-" "adjust" 
                   "<player.item_in_hand>" "lore:<player.item_in_hand.lore.include[<&r>(Socket)]>" "save:item" "}" "else" "{" "-" "adjust" 
                   "<player.item_in_hand>" "lore:<&r>(Socket)" "save:item" "}" 
13:22:29 [INFO] +- Executing dCommand: IF/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'IF': use_braces='true' 
13:22:29 [INFO]  Filled tag <player.item_in_hand.has_lore> with 'false'. 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: ADJUST "<player.item_in_hand>" "lore:<&r>(Socket)" 
13:22:29 [INFO] +- Executing dCommand: ADJUST/p@ImadKWafai ---------+ 
13:22:29 [INFO]  ...remembering this script entry as 'item'! 
13:22:29 [INFO]  Filled tag <player.item_in_hand> with 'i@wooden_sword'. 
13:22:29 [INFO]  Filled tag <&r> with ''. 
13:22:29 [INFO] +> Executing 'ADJUST': object='li@i@wooden_sword'  mechanism='lore'  mechanism_value='(Socket)' 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: ADJUST "<entry[item].result>" "nbt:Socket" 
13:22:29 [INFO] +- Executing dCommand: ADJUST/p@ImadKWafai ---------+ 
13:22:29 [INFO]  ...remembering this script entry as 'item'! 
13:22:29 [INFO]  Filled tag <entry[item].result> with 'i@wooden_sword[lore=&ssr(Socket)]'. 
13:22:29 [INFO] +> Executing 'ADJUST': object='li@i@wooden_sword[lore=&ssr(Socket)]'  mechanism='nbt'  mechanism_value='Socket' 
13:22:29 [INFO]  ERROR in script 'SMITTYSSMITHYHANDLER'! Woah!! An exception has been called with this command (while executing it)! 
13:22:29 [INFO]  ERROR in script 'SMITTYSSMITHYHANDLER'! Internal exception was thrown! 
13:22:29 [SEVERE] java.lang.ArrayIndexOutOfBoundsException: Array index out of range: 1
13:22:29 [SEVERE] net.aufdemrand.denizen.objects.properties.item.ItemNBT.adjust(ItemNBT.java:147)
13:22:29 [SEVERE] net.aufdemrand.denizen.objects.dItem.adjust(dItem.java:1125)
13:22:29 [SEVERE] net.aufdemrand.denizen.scripts.commands.core.AdjustCommand.execute(AdjustCommand.java:100)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.InstantQueue.onStart(InstantQueue.java:61)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.runMeNow(ScriptQueue.java:465)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.start(ScriptQueue.java:516)
13:22:29 [SEVERE] net.aufdemrand.denizencore.events.OldEventManager.doEvents(OldEventManager.java:246)
13:22:29 [SEVERE] net.aufdemrand.denizencore.events.OldEventManager.doEvents(OldEventManager.java:192)
13:22:29 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.BukkitWorldScriptHelper.doEvents(BukkitWorldScriptHelper.java:49)
13:22:29 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.BukkitWorldScriptHelper.inventoryClickEvent(BukkitWorldScriptHelper.java:366)
13:22:29 [SEVERE] com.destroystokyo.paper.event.executor.asm.generated.GeneratedEventExecutor201.execute(Unknown Source)
13:22:29 [SEVERE] org.bukkit.plugin.EventExecutor$2.execute(EventExecutor.java:70)
13:22:29 [SEVERE] co.aikar.timings.TimedEventExecutor.execute(TimedEventExecutor.java:78)
13:22:29 [SEVERE] org.bukkit.plugin.RegisteredListener.callEvent(RegisteredListener.java:62)
13:22:29 [SEVERE] org.bukkit.plugin.SimplePluginManager.callEvent(SimplePluginManager.java:513)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PlayerConnection.a(PlayerConnection.java:2275)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PacketPlayInWindowClick.a(SourceFile:33)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PacketPlayInWindowClick.a(SourceFile:10)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PlayerConnectionUtils.lambda$ensureMainThread$0(PlayerConnectionUtils.java:12)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PlayerConnectionUtils$$Lambda$2150.0000000014189500.run(Unknown Source)
13:22:29 [SEVERE] java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
13:22:29 [SEVERE] java.util.concurrent.FutureTask.run(FutureTask.java:266)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.SystemUtils.a(SystemUtils.java:109)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.MinecraftServer.b(MinecraftServer.java:1016)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.DedicatedServer.b(DedicatedServer.java:439)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.MinecraftServer.a(MinecraftServer.java:943)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.MinecraftServer.run(MinecraftServer.java:841)
13:22:29 [SEVERE] java.lang.Thread.run(Thread.java:813)
13:22:29 [INFO] +> [Denizen] (Attempted: ADJUST "<entry[item].result>" "nbt:Socket" "save:item") 
13:22:29 [INFO] +---------------------+ 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: ADJUST "<player>" "item_in_hand:<entry[item].new_item>" 
13:22:29 [INFO] +- Executing dCommand: ADJUST/p@ImadKWafai ---------+ 
13:22:29 [INFO]  Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'. 
13:22:29 [INFO]  Missing saved entry object 'new_item' 
13:22:29 [INFO]  Filled tag <entry[item].new_item> with 'entry[item].new_item'. 
13:22:29 [INFO]  ERROR in script 'SMITTYSSMITHYHANDLER'! Tag <entry[item].new_item> is invalid! 
13:22:29 [INFO] +> Executing 'ADJUST': object='li@p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'  mechanism='item_in_hand'  
                   mechanism_value='entry[item].new_item' 
13:22:29 [INFO] +> [dItem] valueOf dItem returning null: entry[item].new_item 
13:22:29 [INFO]  ERROR in script 'SMITTYSSMITHYHANDLER'! Woah!! An exception has been called with this command (while executing it)! 
13:22:29 [INFO]  ERROR in script 'SMITTYSSMITHYHANDLER'! Internal exception was thrown! 
13:22:29 [SEVERE] java.lang.NullPointerException
13:22:29 [SEVERE] net.aufdemrand.denizen.objects.dEntity.adjust(dEntity.java:2826)
13:22:29 [SEVERE] net.aufdemrand.denizen.objects.dPlayer.adjust(dPlayer.java:3257)
13:22:29 [SEVERE] net.aufdemrand.denizen.scripts.commands.core.AdjustCommand.execute(AdjustCommand.java:100)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.commands.CommandExecuter.execute(CommandExecuter.java:168)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptEngine.revolve(ScriptEngine.java:70)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.revolve(ScriptQueue.java:670)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.core.InstantQueue.onStart(InstantQueue.java:61)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.runMeNow(ScriptQueue.java:465)
13:22:29 [SEVERE] net.aufdemrand.denizencore.scripts.queues.ScriptQueue.start(ScriptQueue.java:516)
13:22:29 [SEVERE] net.aufdemrand.denizencore.events.OldEventManager.doEvents(OldEventManager.java:246)
13:22:29 [SEVERE] net.aufdemrand.denizencore.events.OldEventManager.doEvents(OldEventManager.java:192)
13:22:29 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.BukkitWorldScriptHelper.doEvents(BukkitWorldScriptHelper.java:49)
13:22:29 [SEVERE] net.aufdemrand.denizen.scripts.containers.core.BukkitWorldScriptHelper.inventoryClickEvent(BukkitWorldScriptHelper.java:366)
13:22:29 [SEVERE] com.destroystokyo.paper.event.executor.asm.generated.GeneratedEventExecutor201.execute(Unknown Source)
13:22:29 [SEVERE] org.bukkit.plugin.EventExecutor$2.execute(EventExecutor.java:70)
13:22:29 [SEVERE] co.aikar.timings.TimedEventExecutor.execute(TimedEventExecutor.java:78)
13:22:29 [SEVERE] org.bukkit.plugin.RegisteredListener.callEvent(RegisteredListener.java:62)
13:22:29 [SEVERE] org.bukkit.plugin.SimplePluginManager.callEvent(SimplePluginManager.java:513)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PlayerConnection.a(PlayerConnection.java:2275)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PacketPlayInWindowClick.a(SourceFile:33)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PacketPlayInWindowClick.a(SourceFile:10)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PlayerConnectionUtils.lambda$ensureMainThread$0(PlayerConnectionUtils.java:12)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.PlayerConnectionUtils$$Lambda$2150.0000000014189500.run(Unknown Source)
13:22:29 [SEVERE] java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
13:22:29 [SEVERE] java.util.concurrent.FutureTask.run(FutureTask.java:266)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.SystemUtils.a(SystemUtils.java:109)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.MinecraftServer.b(MinecraftServer.java:1016)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.DedicatedServer.b(DedicatedServer.java:439)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.MinecraftServer.a(MinecraftServer.java:943)
13:22:29 [SEVERE] net.minecraft.server.v1_13_R2.MinecraftServer.run(MinecraftServer.java:841)
13:22:29 [SEVERE] java.lang.Thread.run(Thread.java:813)
13:22:29 [INFO] +> [Denizen] (Attempted: ADJUST "<player>" "item_in_hand:<entry[item].new_item>") 
13:22:29 [INFO] +---------------------+ 
13:22:29 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: WAIT "3" 
13:22:29 [INFO] +- Executing dCommand: WAIT/p@ImadKWafai ---------+ 
13:22:29 [INFO] +> Executing 'WAIT': queue='SMITTYSSMITHYHANDLER_BryantExistsGalleries'  delay='d@3.0s' 
13:22:29 [INFO]  Forcing queue SMITTYSSMITHYHANDLER_BryantExistsGalleries into a timed queue... 
13:22:29 [INFO]  Completing queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' in 15ms. 
13:22:29 [INFO]  Starting TimedQueue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries'... 
13:22:32 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: NARRATE "Raylin<&co> There you go, choose wisely when adding a 
                   gem!" 
13:22:32 [INFO] +- Executing dCommand: NARRATE/p@ImadKWafai ---------+ 
13:22:32 [INFO]  Filled tag <&co> with ':'. 
13:22:32 [INFO] +> Executing 'NARRATE': Narrating='Raylin: There you go, choose wisely when adding a gem!'  Targets='[p@ImadKWafai]' 
13:22:32 [INFO]  Queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' Executing: QUEUE "clear" 
13:22:32 [INFO] +- Executing dCommand: QUEUE/p@ImadKWafai ---------+ 
13:22:32 [INFO] +> Executing 'QUEUE': queue='q@SMITTYSSMITHYHANDLER_BryantExistsGalleries'  Action='CLEAR' 
13:22:32 [INFO]  Completing queue 'SMITTYSSMITHYHANDLER_BryantExistsGalleries' in 3033ms.