Paste #46836: Denizen Debug Logs From erpg - public server

Date: 2018/03/06 21:14:33 UTC-08:00
Type: Server Log

View Raw Paste Download This Paste
Copy Link


Java Version: 1.8.0_101
Up-time: 42m
CraftBukkit Version: git-Spigot-5695bca-53fccdf (MC: 1.12.2)
Denizen Version: Core: 1.15 (Build Unknown), CraftBukkit: 1.0.2-SNAPSHOT (build Unknown)
Active Plugins (36): dynmap: 2.5-Dev201706100405, HealthBar: 0.1-RELEASE, PlgSetspawn: 5.0, Essentials: TeamCity, 
Craftconomy3: 3.3.1-d99cf63-trv200, WorldBorder: 1.8.7, Modifyworld: 1.20-SNAPSHOT, 
ProtocolLib: 4.3.0, Multiverse-Core: 2.5-b719, LibsDisguises: 9.5.0-SNAPSHOT, 
erpgREQ: 1.0.0, FastAsyncWorldEdit: 18.03.01-b430f47-1020-19.1.15, VoxelSniper: 5.171.0-SNAPSHOT, 
BetterBrushes: 1.0.0.140406, PermissionsEx: 1.23.4, 173generator: ${describe}, 
Vault: 1.6.1, TimeLock: 0.5, WorldEdit: 6.1.8-SNAPSHOT;cd4729f, LogBlock: 1.10.0, 
BKCommonLib: 1.12.2-v4, goBrush: 2.0, LightCleaner: 1.12.2-v2, LWC: 4.4.0 (b881) (July 11, 2013), 
WorldGuard: 6.2.1;84bc322, Citizens: 2.0.22-SNAPSHOT (build 1496), SignColors: 1.1.1, 
SchematicBrush: 0.5.2-Dev201707121734, MythicMobs: 4.2.0-SNAPSHOT, ServerSigns: 4.5.1, 
ChatEx: 1.6, Denizen: 1.0.2-SNAPSHOT (build Unknown), ArmorStandTools: 2.4.3, 
Webizen: 0.2.0, Depenizen: 1.0.0 (build 389), dIRCBot: 0.3 (build 8)
Loaded Worlds (8): OwnReichi, Spielplatz, Arda, BuildLib, noname, erpg, 173pre, 172
Online Players (1): BloodEko(BloodEko)
Offline Players: 42
Mode: online

06:14:12 [INFO] +> Executing 'Action': Type='On CHAT'  NPC='Fährmeister/3'  
                   Container='173_FÄHRMEISTER_AS(ASSIGNMENT)'  Player='BloodEko' 
06:14:12 [INFO] +- Building action 'On CHAT' for Fährmeister/3 ---------+ 
06:14:12 [INFO]  Starting InstantQueue 
                   '173_FÄHRMEISTER_AS_PgpDocumentDollars'... 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   INJECT "profiler" "path:globalStart" 
06:14:12 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'INJECT': script='PROFILER(TASK)'  
                   path='globalStart' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: FLAG 
                   "server" "meta.time:<server.current_time_millis>" 
06:14:12 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <server.current_time_millis> with '1520399652202'. 
06:14:12 [INFO] +> Executing 'FLAG': flag_name='META.TIME'  
                   Action/Value='SET_VALUE(1520399652202)'  flag_target='server' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   DEFINE "script" "<script>" 
06:14:12 [INFO] +- Executing dCommand: DEFINE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <script> with 's@173_FÄHRMEISTER_AS'. 
06:14:12 [INFO] +> Executing 'DEFINE': 
                   queue='173_FÄHRMEISTER_AS_PgpDocumentDollars'  
                   definition='script'  value='s@173_FÄHRMEISTER_AS' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   INJECT "npc" "path:chatEngine" 
06:14:12 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'INJECT': script='NPC(YAML DATA)'  
                   path='chatEngine' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   DETERMINE "passively" "cancelled" 
06:14:12 [INFO] +- Executing dCommand: DETERMINE/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'DETERMINE': outcome='cancelled'  
                   passively='true' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   NARRATE " " 
06:14:12 [INFO] +- Executing dCommand: NARRATE/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'NARRATE': Narrating=' '  Targets='[p@BloodEko]' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: IF 
                   "<player.has_flag[<npc>_engaged]>" "{" "-" "queue" "clear" "}" 
06:14:12 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'IF': use_braces='true' 
06:14:12 [INFO]  Filled tag <npc> with 'n@3'. 
06:14:12 [INFO]  Filled tag <player.has_flag[n@3_engaged]> with 'false'. 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: IF 
                   "<context.message>" "!matches" "number" "||" 
                   "<context.message>" "<" "1" "||" "<context.message>" ">" 
                   "<player.flag[<proc[e-id]>].size||0>" "{" "-" "narrate" 
                   "<&6>Die Zahl ist ungültig!" "-" "queue" "clear" "}" 
06:14:12 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'IF': use_braces='true' 
06:14:12 [INFO]  Filled tag <context.message> with '1'. 
06:14:12 [INFO]  Logic='NEGATIVE', Comparable='Element(1.0)', 
                   Operator='MATCHES', ComparedTo='Element(number)' --> 
                   OUTCOME='false' 
06:14:12 [INFO]  Filled tag <context.message> with '1'. 
06:14:12 [INFO]  Comparable='Decimal(1.0)', Operator='LESS', 
                   ComparedTo='Decimal(1.0)' --> OUTCOME='false' 
06:14:12 [INFO]  Filled tag <context.message> with '1'. 
06:14:12 [INFO]  Starting InstantQueue 'E-ID_NcaaDenizenBb'... 
06:14:12 [INFO]  Queue 'E-ID_NcaaDenizenBb' Executing: DETERMINE 
                   "<npc.flag[enpc]||<npc.as_npc||<player.flag[sp.talking_to].as_npc>>>" 
06:14:12 [INFO] +- Executing dCommand: DETERMINE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag 
                   <npc.flag[enpc]||<npc.as_npc||<player.flag[sp.talking_to].as_npc>>> 
                   with '173_2'. 
06:14:12 [INFO] +> Executing 'DETERMINE': outcome='173_2'  passively='false' 
06:14:12 [INFO]  Completing queue 'E-ID_NcaaDenizenBb' in 1ms. 
06:14:12 [INFO]  Filled tag <proc[e-id]> with '173_2'. 
06:14:12 [INFO]  Filled tag <player.flag[173_2].size||0> with '1'. 
06:14:12 [INFO]  Comparable='Decimal(1.0)', Operator='MORE', 
                   ComparedTo='Decimal(1.0)' --> OUTCOME='false' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: FLAG 
                   "player" "<npc>_engaged" 
06:14:12 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <npc> with 'n@3'. 
06:14:12 [INFO] +> Executing 'FLAG': flag_name='n@3_engaged'  
                   Action/Value='SET_BOOLEAN(true)'  flag_target='p@BloodEko' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   INJECT "<def[script]>" 
                   "<player.flag[<proc[e-id]>].get[<context.message>]>" 
06:14:12 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <def[script]> with 's@173_FÄHRMEISTER_AS'. 
06:14:12 [INFO]  Starting InstantQueue 'E-ID_HoodDriversApparel'... 
06:14:12 [INFO]  Queue 'E-ID_HoodDriversApparel' Executing: DETERMINE 
                   "<npc.flag[enpc]||<npc.as_npc||<player.flag[sp.talking_to].as_npc>>>" 
06:14:12 [INFO] +- Executing dCommand: DETERMINE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag 
                   <npc.flag[enpc]||<npc.as_npc||<player.flag[sp.talking_to].as_npc>>> 
                   with '173_2'. 
06:14:12 [INFO] +> Executing 'DETERMINE': outcome='173_2'  passively='false' 
06:14:12 [INFO]  Completing queue 'E-ID_HoodDriversApparel' in 0ms. 
06:14:12 [INFO]  Filled tag <proc[e-id]> with '173_2'. 
06:14:12 [INFO]  Filled tag <context.message> with '1'. 
06:14:12 [INFO]  Filled tag <player.flag[173_2].get[1]> with '1'. 
06:14:12 [INFO] +> Executing 'INJECT': script='173_FÄHRMEISTER_AS(ASSIGNMENT)' 
                    path='1' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   NARRATE "NANA" 
06:14:12 [INFO] +- Executing dCommand: NARRATE/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'NARRATE': Narrating='NANA'  
                   Targets='[p@BloodEko]' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: IF 
                   "<def[queue]||x>" "!=" "clear" "{" "-" "inject" 
                   "<def[script]>" "loader" "}" 
06:14:12 [INFO] +- Executing dCommand: IF/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'IF': use_braces='true' 
06:14:12 [INFO]  Filled tag <def[queue]||x> with 'x'. 
06:14:12 [INFO]  Logic='NEGATIVE', Comparable='Element(x)', Operator='EQUALS', 
                   ComparedTo='Element(clear)' --> OUTCOME='true' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   INJECT "<def[script]>" "loader" 
06:14:12 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <def[script]> with 's@173_FÄHRMEISTER_AS'. 
06:14:12 [INFO] +> Executing 'INJECT': script='173_FÄHRMEISTER_AS(ASSIGNMENT)' 
                    path='loader' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   FOREACH "<player.flag[<proc[e-id]>].as_list>" "{" "-" 
                   "narrate" "<def[loop_index]>. 
                   <&a><script.constant[<def[value]>]>" "}" 
06:14:12 [INFO] +- Executing dCommand: FOREACH/p@BloodEko ---------+ 
06:14:12 [INFO]  Starting InstantQueue 'E-ID_InvestmentsProcessorBiology'... 
06:14:12 [INFO]  Queue 'E-ID_InvestmentsProcessorBiology' Executing: DETERMINE 
                   "<npc.flag[enpc]||<npc.as_npc||<player.flag[sp.talking_to].as_npc>>>" 
06:14:12 [INFO] +- Executing dCommand: DETERMINE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag 
                   <npc.flag[enpc]||<npc.as_npc||<player.flag[sp.talking_to].as_npc>>> 
                   with '173_2'. 
06:14:12 [INFO] +> Executing 'DETERMINE': outcome='173_2'  passively='false' 
06:14:12 [INFO]  Completing queue 'E-ID_InvestmentsProcessorBiology' in 0ms. 
06:14:12 [INFO]  Filled tag <proc[e-id]> with '173_2'. 
06:14:12 [INFO]  Filled tag <player.flag[173_2].as_list> with 'li@1'. 
06:14:12 [INFO] +> Executing 'FOREACH': list='li@1' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   NARRATE "<def[loop_index]>. 
                   <&a><script.constant[<def[value]>]>" 
06:14:12 [INFO] +- Executing dCommand: NARRATE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <def[loop_index]> with '1'. 
06:14:12 [INFO]  Filled tag <&a> with ''. 
06:14:12 [INFO]  Filled tag <def[value]> with '1'. 
06:14:12 [INFO]  Filled tag <&6> with ''. 
06:14:12 [INFO]  Filled tag <script.constant[1]> with 'Bring mich über das 
                   Wasser. (3 Gold)'. 
06:14:12 [INFO] +> Executing 'NARRATE': Narrating='1. Bring mich über das 
                   Wasser. (3 Gold)'  Targets='[p@BloodEko]' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   FOREACH " CALLBACK" 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   INJECT "profiler" "path:stop" 
06:14:12 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'INJECT': script='PROFILER(TASK)'  path='stop' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   NARRATE "<&e>This action took 
                   <server.current_time_millis.sub[<def[d]>]>ms." 
06:14:12 [INFO] +- Executing dCommand: NARRATE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <&e> with ''. 
06:14:12 [INFO]  ERROR in script 'CUSTOM_EVENT_HANDLER'! Invalid context ID 
                   'script'! 
06:14:12 [INFO]  ERROR in script 'CUSTOM_EVENT_HANDLER'! Tag <context.script> 
                   is invalid! 
06:14:12 [INFO]  ERROR in script 'CUSTOM_EVENT_HANDLER'! Invalid context ID 
                   'queue'! 
06:14:12 [INFO]  ERROR in script 'CUSTOM_EVENT_HANDLER'! Tag <context.queue> 
                   is invalid! 
06:14:12 [INFO]  ERROR! Invalid definition name 'd'. 
06:14:12 [INFO]  Filled tag <def[d]> with 'def[d]'. 
06:14:12 [INFO]  ERROR in script 'NPC'! Tag <def[d]> is invalid! 
06:14:12 [INFO]  Filled tag <server.current_time_millis.sub[def[d]]> with 
                   '1.520399652218E12'. 
06:14:12 [INFO] +> Executing 'NARRATE': Narrating='This action took 
                   1.520399652218E12ms.'  Targets='[p@BloodEko]' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: FLAG 
                   "player" "<npc>_engaged:!" 
06:14:12 [INFO] +- Executing dCommand: FLAG/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <npc> with 'n@3'. 
06:14:12 [INFO] +> Executing 'FLAG': flag_name='N@3_ENGAGED'  
                   Action/Value='DELETE(false)'  flag_target='p@BloodEko' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   INJECT "profiler" "path:globalStop" 
06:14:12 [INFO] +- Executing dCommand: INJECT/p@BloodEko ---------+ 
06:14:12 [INFO] +> Executing 'INJECT': script='PROFILER(TASK)'  
                   path='globalStop' 
06:14:12 [INFO]  Queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' Executing: 
                   NARRATE "<&e>This action took 
                   <server.current_time_millis.sub[<server.flag[meta.time]>]>ms." 
06:14:12 [INFO] +- Executing dCommand: NARRATE/p@BloodEko ---------+ 
06:14:12 [INFO]  Filled tag <&e> with ''. 
06:14:12 [INFO]  Filled tag <server.flag[meta.time]> with '1520399652202'. 
06:14:12 [INFO]  Filled tag <server.current_time_millis.sub[1520399652202]> 
                   with '24'. 
06:14:12 [INFO] +> Executing 'NARRATE': Narrating='This action took 24ms.'  
                   Targets='[p@BloodEko]' 
06:14:12 [INFO]  Completing queue '173_FÄHRMEISTER_AS_PgpDocumentDollars' in 
                   24ms. 
06:14:12 [INFO] +> [] CHAT: BloodEko: 1