Java Version: 1.8.0_192
Up-time: 1h 25m
CraftBukkit Version: git-Paper-500 (MC: 1.13.2)
Denizen Version: Core: 1.30 (Build 192), CraftBukkit: 1.0.3-SNAPSHOT (build 581-DEV)
Active Plugins (28): dynmap: 3.0-beta-2-138, WorldBorder: 1.9.0, Votifier: 2.5.0, ProtocolLib: 4.4.0,
Multiverse-Core: 2.7.0-SNAPSHOT-b747, LibsDisguises: 9.7.1, MythicDrops: 4.3.4-a8b9390,
FastAsyncWorldEdit: 1.0, PermissionsEx: 1.23.4, EffectLib: 6.2-SNAPSHOT, Vault: 1.7.1-b91,
Essentials: 2.16.0.16, HolographicDisplays: 2.3.2, Citizens: 2.0.24-SNAPSHOT (build 1605),
EssentialsProtect: 2.16.0.16, EssentialsChat: 2.16.0.16, EssentialsGeoIP: 2.16.0.16,
EssentialsAntiBuild: 2.16.0.16, EssentialsSpawn: 2.16.0.16, EnjinMinecraftPlugin: 3.5.4,
Denizen: 1.0.3-SNAPSHOT (build 581-DEV), WorldEdit: unspecified, WorldEditSelectionVisualizer: 1.6.2,
FastAsyncVoxelSniper: 1.13.132, WorldGuard: 7.0.0-SNAPSHOT;0dc5781, Depenizen: 1.0.0 (build 426),
Heroes: 1.9.0-SNAPSHOT-4971f3f, MythicMobs: 4.6.0-SNAPSHOT-2646
Loaded Worlds (7): map, map_nether, map_the_end, Temp, map_rainbow, map_spawn, map_dungeons
Online Players (1): [Deity] ~Jimmy(JimyTheLightfoot)
Offline Players: 16
Mode: online
23:46:14 [INFO] +> Executing 'Event': Type='on player clicks CHARACTERSHEETIT in inventory' Container='CHARACTERSHEETHANDLER(WORLD)'
player=p@JimyTheLightfootContext='{item=i@player_head[display_name=Character Sheet;lore=Global Reputation&co 0|Unsung
Reputation&co 0|Cash On Hand&co $6574|Click here to see your Character Information and
Stats&exc;script=CHARACTERSHEETIT;skull_skin=5fb9aeaa-52fd-494a-9388-1f5baab9ed7b|eyJ0aW1lc3RhbXAiOjE1NDg2NDIwMjgxMjUsInByb2ZpbGVJZCI6IjVmYjlhZWFhNTJmZDQ5NGE5Mzg4MWY1YmFhYjllZDdiIiwicHJvZmlsZU5hbWUiOiJKaW15VGhlTGlnaHRmb290IiwidGV4dHVyZXMiOnsiU0tJTiI6eyJ1cmwiOiJodHRwOi8vdGV4dHVyZXMubWluZWNyYWZ0Lm5ldC90ZXh0dXJlLzUxODQ4NmMxNTJiYjA1M2UyMzEyMGExMmNhZTJkNzkwNDVmYjAwOGM2OWQ0NzljMzY1NWFjZTYyYTM2ZDA5NmQifX19|JimyTheLightfoot],
cursor_item=i@air, raw_slot=36, is_shift_click=false, slot_type=CONTAINER, action=PICKUP_ALL, slot=36,
inventory=in@player[holder=p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b], click=LEFT, hotbar_button=0}'
23:46:14 [INFO] +- Building event 'ON PLAYER CLICKS CHARACTERSHEETIT IN INVENTORY' for CHARACTERSHEETHANDLER ---------+
23:46:14 [INFO] Starting InstantQueue 'CHARACTERSHEETHANDLER_NasdaqMarkersFig'...
23:46:14 [INFO] Queue 'CHARACTERSHEETHANDLER_NasdaqMarkersFig' Executing: DETERMINE "passively" "cancelled"
23:46:14 [INFO] +- Executing dCommand: DETERMINE/p@JimyTheLightfoot ---------+
23:46:14 [INFO] +> Executing 'DETERMINE': outcome='cancelled' passively='true'
23:46:14 [INFO] Queue 'CHARACTERSHEETHANDLER_NasdaqMarkersFig' Executing: INVENTORY "open" "d:in@CharacterSheetInv"
23:46:14 [INFO] +- Executing dCommand: INVENTORY/p@JimyTheLightfoot ---------+
23:46:14 [INFO] Filled tag <&0> with ''.
23:46:14 [INFO] Filled tag <&0> with ''.
23:46:14 [INFO] Filled tag <&co> with ':'.
23:46:14 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:14 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[ActiveQuests.Total]> with '1'.
23:46:14 [INFO] Filled tag <&co> with ':'.
23:46:14 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:14 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[CompletedQuests.Total]> with '0'.
23:46:14 [INFO] Filled tag <player.heroes.primary_class.name> with 'Mage'.
23:46:14 [INFO] Filled tag <player.heroes.secondary_class.name> with 'Lumberjack'.
23:46:14 [INFO] Filled tag <&0> with ''.
23:46:14 [INFO] Filled tag <&0> with ''.
23:46:14 [INFO] +> Executing 'INVENTORY': actions='[open]' Inventory='in@CHARACTERSHEETINV' slot='1'
23:46:14 [INFO] Completing queue 'CHARACTERSHEETHANDLER_NasdaqMarkersFig' in 4ms.
23:46:15 [INFO] +> Executing 'Event': Type='on player clicks QUESTLOGI in inventory' Container='QUESTLOGWORLD(WORLD)'
player=p@JimyTheLightfootContext='{item=i@writable_book[display_name=Quest Journal;lore=Click here to access information|about
your Active quests&dot|Active Quests&co 1|Completed Quests&co 0;script=QUESTLOGI], cursor_item=i@air, raw_slot=5,
is_shift_click=false, slot_type=CONTAINER, action=PICKUP_ALL, slot=5, inventory=in@CHARACTERSHEETINV, click=LEFT,
hotbar_button=0}'
23:46:15 [INFO] +- Building event 'ON PLAYER CLICKS QUESTLOGI IN INVENTORY' for QUESTLOGWORLD ---------+
23:46:15 [INFO] Starting InstantQueue 'QUESTLOGWORLD_FrancisGramsScales'...
23:46:15 [INFO] Queue 'QUESTLOGWORLD_FrancisGramsScales' Executing: DETERMINE "passively" "cancelled"
23:46:15 [INFO] +- Executing dCommand: DETERMINE/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'DETERMINE': outcome='cancelled' passively='true'
23:46:15 [INFO] Queue 'QUESTLOGWORLD_FrancisGramsScales' Executing: INVENTORY "open" "d:in@questjournalmenu"
23:46:15 [INFO] +- Executing dCommand: INVENTORY/p@JimyTheLightfoot ---------+
23:46:15 [INFO] Filled tag <&0> with ''.
23:46:15 [INFO] Filled tag <&0> with ''.
23:46:15 [INFO] Filled tag <&co> with ':'.
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[ActiveQuests.Total]> with '1'.
23:46:15 [INFO] Filled tag <&co> with ':'.
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[CompletedQuests.Total]> with '0'.
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Applying property 'skull_skin' on object of type 'Item'...
23:46:15 [INFO] Filled tag <&co> with ':'.
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[GlobalReputation]> with '0'.
23:46:15 [INFO] Filled tag <&co> with ':'.
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[UnsungReputation]> with '0'.
23:46:15 [INFO] Filled tag <&co> with ':'.
23:46:15 [INFO] Filled tag <player.money> with '6574'.
23:46:15 [INFO] Filled tag <&0> with ''.
23:46:15 [INFO] Filled tag <&0> with ''.
23:46:15 [INFO] Starting InstantQueue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin'...
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: IF "<player.has_flag[QJNextPage]>"
23:46:15 [INFO] +- Executing dCommand: IF/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'IF': use_braces='true'
23:46:15 [INFO] Filled tag <player.has_flag[QJNextPage]> with 'false'.
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: FLAG "player"
"QJFirst:<yaml[<player.uuid>].read[ActiveQuests.Total]>"
23:46:15 [INFO] +- Executing dCommand: FLAG/p@JimyTheLightfoot ---------+
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[ActiveQuests.Total]> with '1'.
23:46:15 [INFO] +> Executing 'FLAG': flag_name='QJFIRST' Action/Value='SET_VALUE(1)' flag_target='p@JimyTheLightfoot'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: DEFINE "Total" "<player.flag[QJFIRST]>"
23:46:15 [INFO] +- Executing dCommand: DEFINE/p@JimyTheLightfoot ---------+
23:46:15 [INFO] Filled tag <player.flag[QJFIRST]> with '1'.
23:46:15 [INFO] +> Executing 'DEFINE': queue='INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' definition='total' value='1'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: FOREACH
"<yaml[<player.uuid>].list_keys[ActiveQuests].exclude[Total]>"
23:46:15 [INFO] +- Executing dCommand: FOREACH/p@JimyTheLightfoot ---------+
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].list_keys[ActiveQuests].exclude[Total]> with 'li@test'.
23:46:15 [INFO] +> Executing 'FOREACH': list='li@test'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: IF "<player.flag[QJFirst]>" "==" "<def[Total]>"
23:46:15 [INFO] +- Executing dCommand: IF/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'IF': use_braces='true'
23:46:15 [INFO] Filled tag <player.flag[QJFirst]> with '1'.
23:46:15 [INFO] Filled tag <def[Total]> with '1'.
23:46:15 [INFO] Comparable='Decimal(1.0)', Operator='EQUALS', ComparedTo='Decimal(1.0)' --> OUTCOME='true'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: DEFINE "Quests"
"<yaml[<player.uuid>].read[ActiveQuests.<def[value]>.Item]>"
23:46:15 [INFO] +- Executing dCommand: DEFINE/p@JimyTheLightfoot ---------+
23:46:15 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:15 [INFO] Filled tag <def[value]> with 'test'.
23:46:15 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[ActiveQuests.test.Item]> with
'i@writable_book[display_name=test;lore=test;nbt=li@quest/test;script=QUESTBOOKIT]'.
23:46:15 [INFO] +> Executing 'DEFINE': queue='INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' definition='quests'
value='i@writable_book[display_name=test;lore=test;nbt=li@quest/test;script=QUESTBOOKIT]'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: FLAG "player" "QJFirst:-:1"
23:46:15 [INFO] +- Executing dCommand: FLAG/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'FLAG': flag_name='QJFIRST' Action/Value='DECREASE(1)' flag_target='p@JimyTheLightfoot'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: IF "<player.flag[QJFirst]>" "==" "0"
23:46:15 [INFO] +- Executing dCommand: IF/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'IF': use_braces='true'
23:46:15 [INFO] Filled tag <player.flag[QJFirst]> with '0'.
23:46:15 [INFO] Comparable='Decimal(0.0)', Operator='EQUALS', ComparedTo='Decimal(0.0)' --> OUTCOME='true'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: FLAG "player" "QJFirst:!"
23:46:15 [INFO] +- Executing dCommand: FLAG/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'FLAG': flag_name='QJFIRST' Action/Value='DELETE(false)' flag_target='p@JimyTheLightfoot'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: IF "<player.flag[QJFirst]||1000>" "<" "<def[Total]>"
23:46:15 [INFO] +- Executing dCommand: IF/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'IF': use_braces='true'
23:46:15 [INFO] Filled tag <player.flag[QJFirst]||1000> with '1000'.
23:46:15 [INFO] Filled tag <def[Total]> with '1'.
23:46:15 [INFO] Comparable='Decimal(1000.0)', Operator='LESS', ComparedTo='Decimal(1.0)' --> OUTCOME='false'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: IF "<player.flag[QJFirst]>" "==" "0"
23:46:15 [INFO] +- Executing dCommand: IF/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'IF': use_braces='true'
23:46:15 [INFO] Unfilled attributes 'flag[QJFirst]' for tag <player.flag[QJFirst]>!
23:46:15 [INFO] Filled tag <player.flag[QJFirst]> with 'null'.
23:46:15 [INFO] ERROR in script 'QUESTJOURNALMENU' in queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin'! Tag <player.flag[QJFirst]> is
invalid!
23:46:15 [INFO] Comparable='Element(player.flag[QJFirst])', Operator='EQUALS', ComparedTo='Element(0)' --> OUTCOME='false'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: FOREACH " CALLBACK"
23:46:15 [INFO] +- Foreach loop complete ---------+
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: DEFINE "Inventory" "45"
23:46:15 [INFO] +- Executing dCommand: DEFINE/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'DEFINE': queue='INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' definition='inventory' value='45'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: IF "<def[Inventory]>.sub[<def[Total]>]>" ">" "0"
23:46:15 [INFO] +- Executing dCommand: IF/p@JimyTheLightfoot ---------+
23:46:15 [INFO] +> Executing 'IF': use_braces='true'
23:46:15 [INFO] Filled tag <def[Inventory]> with '45'.
23:46:15 [INFO] Filled tag <def[Total]> with '1'.
23:46:15 [INFO] ERROR in script 'QUESTJOURNALMENU' in queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin'! Comparing text as if it were a
number - comparison automatically false
23:46:15 [INFO] Comparable='Element(45.sub[1]>)', Operator='MORE', ComparedTo='Element(0)' --> OUTCOME='false'
23:46:15 [INFO] Queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' Executing: DETERMINE "<def[Quests]>"
23:46:15 [INFO] +- Executing dCommand: DETERMINE/p@JimyTheLightfoot ---------+
23:46:15 [INFO] Applying property 'display_name' on object of type 'Item'...
23:46:15 [INFO] Applying property 'lore' on object of type 'Item'...
23:46:15 [INFO] Applying property 'nbt' on object of type 'Item'...
23:46:15 [INFO] Applying property 'script' on object of type 'Item'...
23:46:15 [INFO] Filled tag <def[Quests]> with 'i@writable_book[display_name=test;lore=test;nbt=li@quest/test;script=QUESTBOOKIT]'.
23:46:15 [INFO] +> Executing 'DETERMINE': outcome='i@writable_book[display_name=test;lore=test;nbt=li@quest/test;script=QUESTBOOKIT]'
passively='false'
23:46:15 [INFO] Completing queue 'INV_SCRIPT_ITEM_PROC_FoundedInterestingOrigin' in 25ms.
23:46:15 [INFO] Applying property 'display_name' on object of type 'Item'...
23:46:15 [INFO] Applying property 'lore' on object of type 'Item'...
23:46:15 [INFO] Applying property 'nbt' on object of type 'Item'...
23:46:15 [INFO] Applying property 'script' on object of type 'Item'...
23:46:15 [INFO] +> Executing 'INVENTORY': actions='[open]' Inventory='in@QUESTJOURNALMENU' slot='1'
23:46:15 [INFO] Completing queue 'QUESTLOGWORLD_FrancisGramsScales' in 41ms.
23:46:16 [INFO] +> Executing 'Event': Type='on player clicks in QUESTJOURNALMENU' Container='QUESTLOGWORLD(WORLD)'
player=p@JimyTheLightfootContext='{item=i@writable_book[display_name=test;lore=test;nbt=li@quest/test;script=QUESTBOOKIT],
cursor_item=i@air, raw_slot=1, is_shift_click=false, slot_type=CONTAINER, action=PICKUP_ALL, slot=1,
inventory=in@QUESTJOURNALMENU, click=LEFT, hotbar_button=0}'
23:46:16 [INFO] +- Building event 'ON PLAYER CLICKS IN QUESTJOURNALMENU' for QUESTLOGWORLD ---------+
23:46:16 [INFO] Starting InstantQueue 'QUESTLOGWORLD_ClaireMineMixture'...
23:46:16 [INFO] Queue 'QUESTLOGWORLD_ClaireMineMixture' Executing: DETERMINE "cancelled"
23:46:16 [INFO] +- Executing dCommand: DETERMINE/p@JimyTheLightfoot ---------+
23:46:16 [INFO] +> Executing 'DETERMINE': outcome='cancelled' passively='false'
23:46:16 [INFO] Completing queue 'QUESTLOGWORLD_ClaireMineMixture' in 0ms.
23:46:16 [INFO] +> Executing 'Event': Type='on player clicks QUESTBOOKIT in QUESTJOURNALMENU' Container='QUESTLOGWORLD(WORLD)'
player=p@JimyTheLightfootContext='{item=i@writable_book[display_name=test;lore=test;nbt=li@quest/test;script=QUESTBOOKIT],
cursor_item=i@air, raw_slot=1, is_shift_click=false, slot_type=CONTAINER, action=PICKUP_ALL, slot=1,
inventory=in@QUESTJOURNALMENU, click=LEFT, hotbar_button=0}'
23:46:16 [INFO] +- Building event 'ON PLAYER CLICKS QUESTBOOKIT IN QUESTJOURNALMENU' for QUESTLOGWORLD ---------+
23:46:16 [INFO] Starting InstantQueue 'QUESTLOGWORLD_PopulationBanksReveal'...
23:46:16 [INFO] Queue 'QUESTLOGWORLD_PopulationBanksReveal' Executing: INVENTORY "close"
23:46:16 [INFO] +- Executing dCommand: INVENTORY/p@JimyTheLightfoot ---------+
23:46:16 [INFO] +> Executing 'INVENTORY': actions='[close]' Inventory='in@player[holder=p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b]' slot='1'
23:46:16 [INFO] Queue 'QUESTLOGWORLD_PopulationBanksReveal' Executing: RUN "QuestBookTsk" "def:<context.item.nbt[Quest]>"
23:46:16 [INFO] +- Executing dCommand: RUN/p@JimyTheLightfoot ---------+
23:46:16 [INFO] Filled tag <context.item.nbt[Quest]> with 'test'.
23:46:16 [INFO] +> Executing 'RUN': script='QUESTBOOKTSK(TASK)' definitions='test'
23:46:16 [INFO] Adding definition %Quest% as test
23:46:16 [INFO] Starting TimedQueue 'QUESTBOOKTSK_ThatsCageNortheast'...
23:46:16 [INFO] Queue 'QUESTBOOKTSK_ThatsCageNortheast' Executing: INVENTORY "close"
23:46:16 [INFO] +- Executing dCommand: INVENTORY/p@JimyTheLightfoot ---------+
23:46:16 [INFO] +> Executing 'INVENTORY': actions='[close]' Inventory='in@player[holder=p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b]' slot='1'
23:46:16 [INFO] Completing queue 'QUESTLOGWORLD_PopulationBanksReveal' in 1ms.
23:46:16 [INFO] Queue 'QUESTBOOKTSK_ThatsCageNortheast' Executing: ADJUST "i@GenericBook"
"book:<i@GenericBook.book.as_list.replace[“Words”].with[<yaml[<player.uuid>].read[ActiveQuests.<def[Quest]>.Info]>]>"
23:46:16 [INFO] +- Executing dCommand: ADJUST/p@JimyTheLightfoot ---------+
23:46:16 [INFO] ...remembering this script entry as 'book'!
23:46:16 [INFO] Filled tag <player.uuid> with '5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:16 [INFO] Filled tag <def[Quest]> with 'test'.
23:46:16 [INFO] Filled tag <yaml[5fb9aeaa-52fd-494a-9388-1f5baab9ed7b].read[ActiveQuests.test.Info]> with 'test'.
23:46:16 [INFO] Filled tag <i@genericbook.book.as_list.replace[“Words”].with[test]> with 'li@pages|Words'.
23:46:16 [INFO] +> Executing 'ADJUST': object='li@i@GenericBook' mechanism='book' mechanism_value='li@pages|Words'
23:46:16 [INFO] Adjust mechanism 'book' on object of type 'Item'...
23:46:17 [INFO] Queue 'QUESTBOOKTSK_ThatsCageNortheast' Executing: ADJUST "<player>" "fake_equipment:<player>|off_hand|<entry[book].result>"
23:46:17 [INFO] +- Executing dCommand: ADJUST/p@JimyTheLightfoot ---------+
23:46:17 [INFO] Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:17 [INFO] Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:17 [INFO] Filled tag <entry[book].result> with 'i@written_book[book=pages|Words]'.
23:46:17 [INFO] +> Executing 'ADJUST': object='li@p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b' mechanism='fake_equipment'
mechanism_value='p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b|off_hand|i@written_book[book=pages|Words]'
23:46:17 [INFO] Adjust mechanism 'fake_equipment' on object of type 'Player'...
23:46:17 [INFO] Applying property 'book' on object of type 'Item'...
23:46:17 [INFO] Queue 'QUESTBOOKTSK_ThatsCageNortheast' Executing: ADJUST "<player>" "open_offhand_book"
23:46:17 [INFO] +- Executing dCommand: ADJUST/p@JimyTheLightfoot ---------+
23:46:17 [INFO] Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:17 [INFO] +> Executing 'ADJUST': object='li@p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b' mechanism='open_offhand_book'
23:46:17 [INFO] Adjust mechanism 'open_offhand_book' on object of type 'Player'...
23:46:18 [INFO] Queue 'QUESTBOOKTSK_ThatsCageNortheast' Executing: ADJUST "<player>" "fake_equipment:<player>"
23:46:18 [INFO] +- Executing dCommand: ADJUST/p@JimyTheLightfoot ---------+
23:46:18 [INFO] Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:18 [INFO] Filled tag <player> with 'p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'.
23:46:18 [INFO] +> Executing 'ADJUST': object='li@p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b' mechanism='fake_equipment'
mechanism_value='p@5fb9aeaa-52fd-494a-9388-1f5baab9ed7b'
23:46:18 [INFO] Adjust mechanism 'fake_equipment' on object of type 'Player'...
23:46:18 [INFO] Completing queue 'QUESTBOOKTSK_ThatsCageNortheast' in 1995ms.