Java Version: 1.8.0_144
Up-time: 41m
CraftBukkit Version: git-Spigot-573cdf2-1b982fd (MC: 1.13.2)
Denizen Version: Core: 1.20 (Build 171), CraftBukkit: 1.0.3-SNAPSHOT (build 502-DEV)
Active Plugins (4): iConomy: 6.0.10b, Vault: 1.6.7-b${env.TRAVIS_BUILD_NUMBER}, Citizens: 2.0.24-SNAPSHOT (build 1604),
Denizen: 1.0.3-SNAPSHOT (build 502-DEV)
Loaded Worlds (3): adventure map, adventure map_nether, adventure map_the_end
Online Players (1): calicokid(calicokid)
Offline Players: 77
Mode: online
17:01:20 [INFO] +> Executing 'Action': Type='On DAMAGE' NPC='n@39' Container='STOREKEEPERPLAYEROWNED(ASSIGNMENT)' Player='calicokid'
17:01:20 [INFO] +- Building action 'On DAMAGE' for n@39 ---------+
17:01:20 [INFO] Starting InstantQueue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated'...
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: DEFINE "name" "<player.name>"
17:01:20 [INFO] +- Executing dCommand: DEFINE/p@calicokid ---------+
17:01:20 [INFO] Filled tag <player.name> with 'calicokid'.
17:01:20 [INFO] +> Executing 'DEFINE': queue='STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' definition='name' value='calicokid'
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: IF "<player.uuid>" "=="
"<npc.owner.uuid||npc.owner>"
17:01:20 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:20 [INFO] +> Executing 'IF': use_braces='true'
17:01:20 [INFO] Filled tag <player.uuid> with 'ba85964b-f511-4ca7-b1ca-df6ce1f78755'.
17:01:20 [INFO] Filled tag <npc.owner.uuid||npc.owner> with 'npc.owner'.
17:01:20 [INFO] Comparable='Element(ba85964b-f511-4ca7-b1ca-df6ce1f78755)', Operator='EQUALS', ComparedTo='Element(npc.owner)' -->
OUTCOME='false'
17:01:20 [INFO] Filled tag <player.inventory.contains[i@shopping_bag]> with 'false'.
17:01:20 [INFO] Filled tag <green> with ''.
17:01:20 [INFO] Filled tag <green> with ''.
17:01:20 [INFO] Filled tag <green> with ''.
17:01:20 [INFO] Filled tag <player.inventory.contains[i@selling_bag]||> with 'false'.
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: NOTE "in@player bag"
"as:<player.name>_shopping_bag"
17:01:20 [INFO] +- Executing dCommand: NOTE/p@calicokid ---------+
17:01:20 [INFO] Filled tag <player.name> with 'calicokid'.
17:01:20 [INFO] +> Executing 'NOTE': object='in@player bag' id='calicokid_shopping_bag' remove='false'
17:01:20 [INFO] Filled tag <aqua> with ''.
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: ANIMATE "<npc>" "arm_swing"
17:01:20 [INFO] +- Executing dCommand: ANIMATE/p@calicokid ---------+
17:01:20 [INFO] Filled tag <npc> with 'n@39'.
17:01:20 [INFO] +> Executing 'ANIMATE': animation='ARM_SWING' entities='[n@39]'
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: FLAG "player" "storekeepernpc:<npc>"
17:01:20 [INFO] +- Executing dCommand: FLAG/p@calicokid ---------+
17:01:20 [INFO] Filled tag <npc> with 'n@39'.
17:01:20 [INFO] +> Executing 'FLAG': flag_name='STOREKEEPERNPC' Action/Value='SET_VALUE(n@39)' flag_target='p@calicokid'
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: NARRATE "<aqua>Here, have a complimentary
shopping_bag!"
17:01:20 [INFO] +- Executing dCommand: NARRATE/p@calicokid ---------+
17:01:20 [INFO] Filled tag <aqua> with ''.
17:01:20 [INFO] +> Executing 'NARRATE': Narrating='Here, have a complimentary shopping_bag!' Targets='[p@calicokid]'
17:01:20 [INFO] Queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' Executing: GIVE "i@shopping_bag"
17:01:20 [INFO] +- Executing dCommand: GIVE/p@calicokid ---------+
17:01:20 [INFO] +> Executing 'GIVE': Type='ITEM' inventory='in@player[holder=p@ba85964b-f511-4ca7-b1ca-df6ce1f78755]' Quantity='1.0'
engrave='false' unlimit_stack_size='false' Items='[i@SHOPPING_BAG[display_name=shopping bag;lore=Give this to a shopkeeper
to check out|by right clicking him with it&dot|Right click to see the contents&dot|Left click the shopkeeper to see the
price˙skull_skin=02d014dd-6d1a-4056-ba55-977918442838|eyJ0ZXh0dXJlcyI6eyJTS0lOIjp7InVybCI6Imh0dHA6Ly90ZXh0dXJlcy5taW5lY3JhZnQubmV0L3R
leHR1cmUvYmY0MGM3NzE2MjY3YjFmNDY5YWU3MzBkMDEzYjE0MDAyN2Q4NDE5YzEyZDcxZjA3MTk4MTdhYzBhMWY3ZjA5ZCJ9fX0=]]' slot='1'
17:01:20 [INFO] Completing queue 'STOREKEEPERPLAYEROWNED_RecordingsAppearedSophisticated' in 23ms.
17:01:22 [INFO] Running script event 'PlayerRightClicksEntity', event='player right clicks item_frame' for script 'ITEM FRAME SHOP PLAYER
OWNED'
17:01:22 [INFO] Starting InstantQueue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans'...
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: DEFINE "name" "<player.name>"
17:01:22 [INFO] +- Executing dCommand: DEFINE/p@calicokid ---------+
17:01:22 [INFO] Filled tag <player.name> with 'calicokid'.
17:01:22 [INFO] +> Executing 'DEFINE': queue='ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' definition='name' value='calicokid'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: FOREACH "<global.flag[store].escape_contents||li@>"
17:01:22 [INFO] +- Executing dCommand: FOREACH/p@calicokid ---------+
17:01:22 [INFO] Filled tag <global.flag[store].escape_contents||li@> with 'li@cu&atl&at-1588&dot0,71&dot0,382&dot0,adventure
map&pipel&at-1577&dot0,62&dot0,371&dot0,adventure map|cu&atl&at217&dot0,70&dot0,296&dot0,adventure
map&pipel&at231&dot0,63&dot0,305&dot0,adventure map'.
17:01:22 [INFO] +> Executing 'FOREACH': list='li@cu&atl&at-1588&dot0,71&dot0,382&dot0,adventure
map&pipel&at-1577&dot0,62&dot0,371&dot0,adventure map|cu&atl&at217&dot0,70&dot0,296&dot0,adventure
map&pipel&at231&dot0,63&dot0,305&dot0,adventure map'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: IF
"<context.location.is_within[<def[value].unescaped.as_cuboid>]||false>"
17:01:22 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'IF': use_braces='true'
17:01:22 [INFO] Filled tag <def[value].unescaped.as_cuboid> with 'cu@-1588,62,371,adventure map|-1577,71,382,adventure map'.
17:01:22 [INFO] Filled tag <context.location.is_within[cu@-1588,62,371,adventure map|-1577,71,382,adventure map]||false> with 'false'.
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: FOREACH " CALLBACK"
17:01:22 [INFO] +- Foreach loop 2 ---------+
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: IF
"<context.location.is_within[<def[value].unescaped.as_cuboid>]||false>"
17:01:22 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'IF': use_braces='true'
17:01:22 [INFO] Filled tag <def[value].unescaped.as_cuboid> with 'cu@217,63,296,adventure map|231,70,305,adventure map'.
17:01:22 [INFO] Filled tag <context.location.is_within[cu@217,63,296,adventure map|231,70,305,adventure map]||false> with 'true'.
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: IF "<player.is_op>" "&&" "<player.is_sneaking>"
17:01:22 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'IF': use_braces='true'
17:01:22 [INFO] Filled tag <player.is_op> with 'true'.
17:01:22 [INFO] Filled tag <player.is_sneaking> with 'false'.
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: DETERMINE "passively" "cancelled"
17:01:22 [INFO] +- Executing dCommand: DETERMINE/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'DETERMINE': outcome='cancelled' passively='true'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: IF "<player.item_in_hand.simple||false>" "=="
"i@shopping_bag"
17:01:22 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'IF': use_braces='true'
17:01:22 [INFO] Filled tag <player.item_in_hand.simple||false> with 'i@SHOPPING_BAG'.
17:01:22 [INFO] Comparable='Element(i@SHOPPING_BAG)', Operator='EQUALS', ComparedTo='Element(i@shopping_bag)' --> OUTCOME='true'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: IF "<in@%name%_shopping_bag.stacks>" "=" "18"
17:01:22 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:22 [INFO] Filled definition %name% with 'calicokid'.
17:01:22 [INFO] +> Executing 'IF': use_braces='true'
17:01:22 [INFO] Filled tag <in@calicokid_shopping_bag.stacks> with '0'.
17:01:22 [INFO] Comparable='Decimal(0.0)', Operator='EQUALS', ComparedTo='Decimal(18.0)' --> OUTCOME='false'
17:01:22 [INFO] Filled tag <player.flag[storekeepernpc].as_npc.owner> with 'server'.
17:01:22 [INFO] Comparable='Element(server)', Operator='EQUALS', ComparedTo='Element(server)' --> OUTCOME='true'
17:01:22 [INFO] Filled tag <context.entity.framed_item.escaped> with 'i&atwooden_sword'.
17:01:22 [INFO] Filled tag <yaml[prices].read[prices.i&atwooden_sword]||null> with '15'.
17:01:22 [INFO] Comparable='Element(15.0)', Operator='EQUALS', ComparedTo='Element(null)' --> OUTCOME='false'
17:01:22 [INFO] Filled tag <player.flag[storekeepernpc].as_npc.owner> with 'server'.
17:01:22 [INFO] Comparable='Element(server)', Operator='EQUALS', ComparedTo='Element(server)' --> OUTCOME='true'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: INVENTORY "add" "o:<c.entity.framed_item>"
"d:in@<player.name>_shopping_bag"
17:01:22 [INFO] +- Executing dCommand: INVENTORY/p@calicokid ---------+
17:01:22 [INFO] Filled tag <c.entity.framed_item> with 'i@wooden_sword'.
17:01:22 [INFO] Filled tag <player.name> with 'calicokid'.
17:01:22 [INFO] +> Executing 'INVENTORY': actions='[add]' Inventory='in@calicokid_shopping_bag'
Inventory='in@generic[size=54;contents=li@i@wooden_sword;title=Chest]' slot='1'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: IF "<c.entity.framed_item.display||null>" "!=" "null"
17:01:22 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'IF': use_braces='true'
17:01:22 [INFO] Filled tag <c.entity.framed_item.display||null> with 'null'.
17:01:22 [INFO] Logic='NEGATIVE', Comparable='Element(null)', Operator='EQUALS', ComparedTo='Element(null)' --> OUTCOME='false'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: NARRATE "<aqua>You add
<green><c.entity.framed_item.material.name.replace[_].with[ ]> <aqua>to your shopping bag."
17:01:22 [INFO] +- Executing dCommand: NARRATE/p@calicokid ---------+
17:01:22 [INFO] Filled tag <aqua> with ''.
17:01:22 [INFO] Filled tag <green> with ''.
17:01:22 [INFO] Filled tag <c.entity.framed_item.material.name.replace[_].with[ ]> with 'wooden sword'.
17:01:22 [INFO] Filled tag <aqua> with ''.
17:01:22 [INFO] +> Executing 'NARRATE': Narrating='You add wooden sword to your shopping bag.' Targets='[p@calicokid]'
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: PLAYSOUND "<player>" "sound:DIG_GRASS"
17:01:22 [INFO] +- Executing dCommand: PLAYSOUND/p@calicokid ---------+
17:01:22 [INFO] Filled tag <player> with 'p@ba85964b-f511-4ca7-b1ca-df6ce1f78755'.
17:01:22 [INFO] +> Executing 'PLAYSOUND': entities='[p@ba85964b-f511-4ca7-b1ca-df6ce1f78755]' sound='DIG_GRASS' volume='1' pitch='1'
custom='false'
17:01:22 [INFO] Unable to play sound.
17:01:22 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' Executing: DETERMINE "cancelled"
17:01:22 [INFO] +- Executing dCommand: DETERMINE/p@calicokid ---------+
17:01:22 [INFO] +> Executing 'DETERMINE': outcome='cancelled' passively='false'
17:01:22 [INFO] Completing queue 'ITEM FRAME SHOP PLAYER OWNED_AlienRarelyTitans' in 63ms.
17:01:22 [INFO] Event cancelled!
17:01:22 [INFO] Event cancelled!
17:01:24 [INFO] Filled tag <red> with ''.
17:01:24 [INFO] Running script event 'PlayerClicksBlock', event='player right clicks with shopping_bag' for script 'ITEM FRAME SHOP PLAYER
OWNED'
17:01:24 [INFO] Starting InstantQueue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian'...
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: DEFINE "name" "<player.name>"
17:01:24 [INFO] +- Executing dCommand: DEFINE/p@calicokid ---------+
17:01:24 [INFO] Filled tag <player.name> with 'calicokid'.
17:01:24 [INFO] +> Executing 'DEFINE': queue='ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' definition='name' value='calicokid'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: DEFINE "is_shopping" "false"
17:01:24 [INFO] +- Executing dCommand: DEFINE/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'DEFINE': queue='ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' definition='is_shopping' value='false'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: FOREACH "<global.flag[store].escape_contents||li@>"
17:01:24 [INFO] +- Executing dCommand: FOREACH/p@calicokid ---------+
17:01:24 [INFO] Filled tag <global.flag[store].escape_contents||li@> with 'li@cu&atl&at-1588&dot0,71&dot0,382&dot0,adventure
map&pipel&at-1577&dot0,62&dot0,371&dot0,adventure map|cu&atl&at217&dot0,70&dot0,296&dot0,adventure
map&pipel&at231&dot0,63&dot0,305&dot0,adventure map'.
17:01:24 [INFO] +> Executing 'FOREACH': list='li@cu&atl&at-1588&dot0,71&dot0,382&dot0,adventure
map&pipel&at-1577&dot0,62&dot0,371&dot0,adventure map|cu&atl&at217&dot0,70&dot0,296&dot0,adventure
map&pipel&at231&dot0,63&dot0,305&dot0,adventure map'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: IF
"<player.location.is_within[<def[value].unescaped>]>"
17:01:24 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'IF': use_braces='true'
17:01:24 [INFO] Filled tag <def[value].unescaped> with 'cu@l@-1588.0,71.0,382.0,adventure map|l@-1577.0,62.0,371.0,adventure map'.
17:01:24 [INFO] Filled tag <player.location.is_within[cu@l@-1588.0,71.0,382.0,adventure map|l@-1577.0,62.0,371.0,adventure map]> with
'false'.
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: FOREACH " CALLBACK"
17:01:24 [INFO] +- Foreach loop 2 ---------+
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: IF
"<player.location.is_within[<def[value].unescaped>]>"
17:01:24 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'IF': use_braces='true'
17:01:24 [INFO] Filled tag <def[value].unescaped> with 'cu@l@217.0,70.0,296.0,adventure map|l@231.0,63.0,305.0,adventure map'.
17:01:24 [INFO] Filled tag <player.location.is_within[cu@l@217.0,70.0,296.0,adventure map|l@231.0,63.0,305.0,adventure map]> with 'true'.
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: DEFINE "is_shopping" "true"
17:01:24 [INFO] +- Executing dCommand: DEFINE/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'DEFINE': queue='ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' definition='is_shopping' value='true'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: FOREACH "stop"
17:01:24 [INFO] +- Executing dCommand: FOREACH/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'FOREACH': stop='true'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: IF "!<player.inventory.qty[" "shopping_bag" "]>"
">=" "2"
17:01:24 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'IF': use_braces='true'
17:01:24 [INFO] ERROR in script 'ITEM FRAME SHOP PLAYER OWNED' in queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian'! If command
syntax invalid - possibly wrong number of arguments (check for stray spaces)? IllegalArgumentException: No enum constant
net.aufdemrand.denizencore.scripts.commands.core.Comparable.Operator.SHOPPING_BAG
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: IF "!%is_shopping%"
17:01:24 [INFO] +- Executing dCommand: IF/p@calicokid ---------+
17:01:24 [INFO] Filled definition %is_shopping% with 'true'.
17:01:24 [INFO] +> Executing 'IF': use_braces='true'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: DEFINE "player" "<player.name>"
17:01:24 [INFO] +- Executing dCommand: DEFINE/p@calicokid ---------+
17:01:24 [INFO] Filled tag <player.name> with 'calicokid'.
17:01:24 [INFO] +> Executing 'DEFINE': queue='ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' definition='player' value='calicokid'
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: ELSE "if" "<inventory.def[player]_shopping_bag>"
"==" "null" "&&" "%is_shopping%"
17:01:24 [INFO] +- Executing dCommand: ELSE/p@calicokid ---------+
17:01:24 [INFO] Filled definition %is_shopping% with 'true'.
17:01:24 [INFO] Filled tag <inventory.def[player]_shopping_bag> with 'inventory.def[player]_shopping_bag'.
17:01:24 [INFO] ERROR in script 'ITEM FRAME SHOP PLAYER OWNED' in queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian'! Tag
<inventory.def[player]_shopping_bag> is invalid!
17:01:24 [INFO] ERROR in script 'ITEM FRAME SHOP PLAYER OWNED' in queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian'! Misplaced
ELSE command.
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: ELSE "if" "%is_shopping%"
17:01:24 [INFO] +- Executing dCommand: ELSE/p@calicokid ---------+
17:01:24 [INFO] Filled definition %is_shopping% with 'true'.
17:01:24 [INFO] ERROR in script 'ITEM FRAME SHOP PLAYER OWNED' in queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian'! Misplaced
ELSE command.
17:01:24 [INFO] Queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' Executing: DETERMINE "cancelled"
17:01:24 [INFO] +- Executing dCommand: DETERMINE/p@calicokid ---------+
17:01:24 [INFO] +> Executing 'DETERMINE': outcome='cancelled' passively='false'
17:01:24 [INFO] Completing queue 'ITEM FRAME SHOP PLAYER OWNED_KeywordGenerateLibrarian' in 12ms.
17:01:24 [INFO] Event cancelled!