14:44:24.104 WARN 18184 proxy:148 proxy from 2024-01-27T02:02:24.754032100Z is initializing 14:44:24.106 INFO 18184 proxy::patches::debug::not_a_game_talk:22 not a game talk hooks initialized 14:44:24.106 TRACE 18184 proxy::patches::debug::lua:63 ScriptTraceConfig { trace_lua_calls: false, trace_lua_assignments: false, trace_lua_chunk_parsing: false, map_scripts: MapScriptsConfig { trace_state_transitions: false, trace_all_action_creation: false, trace_before_all_action_call: false, trace_after_all_action_call: false, script_actions: {} }, extra_log_file: None, delete_trace: false, print_to_log: false } 14:44:24.106 INFO 18184 proxy::patches::debug::lua::script_actions:177 Scrip actions initialized 14:44:24.106 INFO 18184 proxy::patches::debug::lua:105 lua tracing initialized 14:44:24.107 INFO 18184 proxy::patches::lua_functions:33 lua hooks initialized 14:44:24.108 INFO 18184 proxy::patches::lua_functions::gds::entity_effect_start:17 lua gds entity effect start hooks initialized 14:44:24.108 INFO 18184 proxy::patches::lua_functions::gds:34 lua gds hooks initialized 14:44:24.108 INFO 18184 proxy::patches::lua_functions::cpg_card:19 lua card hooks initialized 14:44:24.108 INFO 18184 proxy::patches::lua_functions::player:20 lua player hooks initialized 14:44:24.108 INFO 18184 proxy::patches::lua_functions::widget:21 lua widget hooks initialized 14:44:24.109 INFO 18184 proxy::patches::lua_functions::chat_channel:32 chat channel hooks initialized 14:44:24.109 INFO 18184 proxy::patches::lua_functions::luabind:22 Luabind hooks initialized 14:44:24.110 INFO 18184 proxy::patches::bugs::skip_broken_effects:17 'bad' effects should not crash 14:44:24.110 INFO 18184 proxy::patches::bugs::stampede:9 Stampede fix initialized 14:44:24.113 INFO 18184 proxy::patches::changes::abilities::spell_blocker:15 Ability AbilitySpellBlocker new param hooks initialized 14:44:24.114 INFO 18184 proxy::patches::changes::mind_control:9 Mind control limit bypass initialized 14:44:24.114 INFO 18184 proxy::patches::changes::elements::card_enum:22 Card rendering initialized 14:44:24.114 INFO 18184 proxy::patches::changes::global_buffs:27 global buffs hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::half_orb:38 half orbs hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::map_crc:13 Map CRC hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::finished_maps:17 Finished maps hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::new_spells:23 New spells hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::new_spell_conditions:19 New spell condition hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::context_menu_player:15 Context menu player extension hooks initialized 14:44:24.115 INFO 18184 proxy::patches::changes::ability_ability_dependend_ability:53 Ability AbilityDependendAbility new param hooks initialized 14:44:24.116 INFO 18184 proxy::patches::changes::ability_immunity:36 Ability AbilityImmunity new param hooks initialized 14:44:24.116 INFO 18184 proxy::patches::changes::spell_condition_unit_cap:21 Spell Condition new param hooks initialized 14:44:24.116 INFO 18184 proxy::patches::changes::ability_dot:17 Ability DOT new param hooks initialized 14:44:24.116 INFO 18184 proxy::patches::changes::forge_map:23 forge map selected 14:44:24.117 INFO 18184 proxy::patches::changes::hot_keys::replay:23 Replay hooks initialized 14:44:24.117 INFO 18184 proxy::patches::changes::hot_keys:63 Hot key hooks initialized 14:44:24.118 INFO 18184 proxy::patches::changes::chat_commands:54 Chat commands hooks initialized 14:44:24.118 INFO 18184 proxy::patches::changes::void_return:24 void return hooks initialized 14:44:24.119 INFO 18184 proxy::patches::changes::building_spawn_animations:41 construction helper hooks initialized 14:44:24.119 INFO 18184 proxy::patches::changes::dazed_immunity_addition:14 Dazed immunity addition initialized 14:44:24.119 INFO 18184 proxy::patches::changes::max_heal_per_target:18 max heal per target initialized 14:44:24.119 INFO 18184 proxy::patches::changes::ability_prevent_card_play_enemy_bypass:15 prevent card play bypass initialized 14:44:24.120 INFO 18184 proxy::patches::changes::community_map:57 community map hooks initialized 14:44:24.120 INFO 18184 proxy::patches::changes::super_weapon:23 Bedrock action initialized 14:44:24.121 INFO 18184 proxy::patches::changes::loca_string_processing:33 Loca string processing initialized 14:44:24.121 INFO 18184 proxy::patches::changes::game_commands:51 Game commands hooks initialized 14:44:24.121 INFO 18184 proxy::patches::on_tick:28 on tick hooks initialized 14:44:24.122 INFO 18184 proxy::patches::map_presets:43 tests hooks initialized 14:44:24.123 INFO 18184 proxy::patches::files_system:67 base file system hooks initialized 14:44:24.123 INFO 18184 proxy::patches::files_system:79 map file system hooks initialized 14:44:24.124 INFO 18184 proxy::patches::inventory:38 inventory hooks initialized 14:44:24.124 INFO 18184 proxy::networking::connect:203 connect disconnect hooks initialized 14:44:24.124 INFO 18184 proxy::networking:33 networking hooks initialized 14:44:24.124 WARN 18184 proxy:166 Initialized successfully 14:44:24.125 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x1eb8 name: Job Processor 14:44:24.126 TRACE 7864 proxy::logging::bf_exceptions:45 Thread id: 0x1eb8 name: Job Processor 14:44:24.426 WARN 18184 proxy::game_config::get_set:104 application:maxshader '"0"' is not a int 14:44:24.431 INFO 18184 proxy::logging:150 src="Direct3D 9" message="Start Scan" 14:44:24.465 INFO 18184 proxy::logging:150 src="Direct3D 9" message="Found Adapter: NVIDIA GeForce GTX 1080" 14:44:24.465 INFO 18184 proxy::logging:150 src="Direct3D 9" message="Support Hardware vertex processing" 14:44:24.465 INFO 18184 proxy::logging:150 src="Direct3D 9" message="Support SM 3.0" 14:44:24.465 INFO 18184 proxy::logging:150 src="Direct3D 9" message="End Scan" 14:44:24.466 INFO 18184 proxy::logging:150 src="Direct3D 11" message="Start DXGI scan." 14:44:24.468 INFO 18184 proxy::logging:150 src="Direct3D 11" message="Found Adapter: NVIDIA GeForce GTX 1080" 14:44:24.560 INFO 18184 proxy::logging:150 src="Direct3D 11" message="Supports Techlevel 11.0" 14:44:24.560 INFO 18184 proxy::logging:150 src="Direct3D 11" message="End DXGI scan." 14:44:24.562 INFO 18184 proxy::logging:150 src="app" message="BattleForge Final Build: 400045 (Retail branch)" 14:44:24.562 INFO 18184 proxy::logging:150 src="app" message="CPU GenuineIntel family 6, model 14 (Core) detected." 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x3f90 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x 390 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x4a70 name: Job Processor 14:44:24.562 TRACE 16272 proxy::logging::bf_exceptions:45 Thread id: 0x3f90 name: Job Processor 14:44:24.562 TRACE 912 proxy::logging::bf_exceptions:45 Thread id: 0x 390 name: Job Processor 14:44:24.562 TRACE 19056 proxy::logging::bf_exceptions:45 Thread id: 0x4a70 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x2650 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x5bd4 name: Job Processor 14:44:24.562 TRACE 9808 proxy::logging::bf_exceptions:45 Thread id: 0x2650 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x5044 name: Job Processor 14:44:24.562 TRACE 23508 proxy::logging::bf_exceptions:45 Thread id: 0x5bd4 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x3600 name: Job Processor 14:44:24.562 TRACE 20548 proxy::logging::bf_exceptions:45 Thread id: 0x5044 name: Job Processor 14:44:24.562 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x37f0 name: PeriodicJobDispatcher 14:44:24.562 TRACE 13824 proxy::logging::bf_exceptions:45 Thread id: 0x3600 name: Job Processor 14:44:24.562 WARN 18184 proxy::bf_utils::fs::pak_files:122 Loading paks from: '"base\\pak"' (base/pak/) 14:44:24.562 TRACE 14320 proxy::logging::bf_exceptions:45 Thread id: 0x37f0 name: PeriodicJobDispatcher 14:44:24.563 INFO 18184 proxy::bf_utils::fs::pak_files:153 loading files from: base\pak 14:44:25.044 INFO 18184 proxy::logging:150 src="app" message="CPU clock speed is ~4200 MHz." 14:44:25.044 INFO 18184 proxy::logging:150 src="app" message="CPU has 8 cores." 14:44:25.044 INFO 18184 proxy::logging:150 src="app" message="CPU rating is 0 points." 14:44:25.044 INFO 18184 proxy::logging:150 src="app" message="GFX rating is 0 points." 14:44:25.044 INFO 18184 proxy::logging:150 src="CreateDisplay" message="Creating Display DirectX 11" 14:44:25.069 INFO 18184 proxy::logging:150 src="Create Device" message="Use Direct3D 11" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Vendor ID = 0x10de" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Device ID = 0x1b80" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Subsystem ID = 0x1425174b" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Revision = 0xa1" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Device description = NVIDIA GeForce GTX 1080" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Video Memory = -1073741824" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="System Memory = 0" 14:44:25.074 INFO 18184 proxy::logging:150 src="GPU" message="Shared Memory = 1073676288" 14:44:25.085 WARN 18184 proxy::logging:151 src="Direct3D 11" message="Create shader resource view : S_OK" 14:44:25.434 TRACE 8316 proxy::patches::inventory:80 loading took: 396.0118ms 14:44:25.663 INFO 18184 proxy::logging:150 src="PssSoundPipeline" message="Loading soundpipeline: Version: 1 Number of Files:9721" 14:44:25.923 INFO 18184 proxy::logging:150 src="PssSoundPipeline" message="Loading soundpipeline bf1/sound/SoundPipeline_en.bin finished, 38747.11 seconds of music material in pipe." 14:44:25.972 INFO 18184 proxy::logging:150 src="CPssPhysicalRenderer" message="Got 7.1 Surround mapped to 5.1 speakers!" 14:44:26.128 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x28dc name: RWAudioCore Dac 14:44:26.128 TRACE 10460 proxy::logging::bf_exceptions:45 Thread id: 0x28dc name: RWAudioCore Dac 14:44:26.129 INFO 18184 proxy::logging:150 src="VisManager" message="Loaded 4 different playercolors." 14:44:26.129 INFO 18184 proxy::logging:150 src="VisManager" message="Loaded 5 Flame Locator mappings" 14:44:26.129 INFO 18184 proxy::logging:150 src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 14:44:26.240 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x56dc name: MoviePlayer2 Decode Thread 14:44:26.240 TRACE 22236 proxy::logging::bf_exceptions:45 Thread id: 0x56dc name: MoviePlayer2 Decode Thread 14:44:26.240 TRACE 22236 proxy::logging::bf_exceptions:45 Thread id: 0x4678 name: 14:44:26.308 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x4464 name: MoviePlayer2 Decode Thread 14:44:26.309 TRACE 17508 proxy::logging::bf_exceptions:45 Thread id: 0x4464 name: MoviePlayer2 Decode Thread 14:44:26.312 TRACE 18184 proxy::logging::bf_exceptions:45 Thread id: 0x c84 name: MoviePlayer2 Decode Thread 14:44:26.312 TRACE 3204 proxy::logging::bf_exceptions:45 Thread id: 0x c84 name: MoviePlayer2 Decode Thread 14:44:26.322 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [timed_task_manager.lub:18] Created new anonymous task" 14:44:26.322 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [card_double_click_context.lub:16] Restoring inventory card click handler to default" 14:44:26.322 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [card_double_click_context.lub:27] Setting inventory card click handler to 'add_to_deck'" 14:44:26.347 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [event_listener.lub:20] Register EventListener with id 55" 14:44:26.499 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:224] SectionBrowser:SwitchSection to Login" 14:44:26.499 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:259] SectionBrowser.SwitchSection: Opening section 'Login'" 14:44:26.499 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_screen_flow.lub:53] ScreenFlow:Next(bf1/ui/dialogs/pregame/login/pg_login_view.xml)" 14:44:26.499 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_screen_flow.lub:11] DoTransition: bf1/ui/dialogs/pregame/login/pg_login_view.xml" 14:44:26.499 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_screen_flow.lub:35] OnNextView! #0" 14:44:26.499 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:83] Creating view bf1/ui/dialogs/pregame/login/pg_login_view.xml" 14:44:26.523 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [timed_task_manager.lub:13] Created new task ReEnableLogin" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:32] PregameSection.Open" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:39] PregameSection.Open: Setting position on screen" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:43] PregameSection.Open: Initialize controller" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:52] Show ActiveView" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:32] PregameSection.Open" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:39] PregameSection.Open: Setting position on screen" 14:44:26.525 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:43] PregameSection.Open: Initialize controller" 14:44:26.526 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:52] Show ActiveView" 14:44:30.893 INFO 18184 proxy::networking::connect:257 connecting 14:44:30.893 INFO 18184 proxy::networking::connect:320 forge_connect 14:44:30.963 INFO 18184 proxy::networking::connect:359 connected TlsStream { io: PollEvented { io: Some(TcpStream { addr: 192.168.1.7:53584, peer: 162.55.91.56:7401, socket: 12512 }) }, session: ClientConnection, state: Stream } 14:44:30.963 INFO 18184 proxy::networking::connect:262 fully connected 14:44:30.976 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_notification_listener.lub:185] Adding notification listener..." 14:44:30.976 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_notification_listener.lub:187] Notification listener added!" 14:44:30.976 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:111] Adding packet listener..." 14:44:30.976 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:113] Packet listener added!" 14:44:30.995 DEBUG 14272 sr_packet::from_game::borderline::BorderlineMessage_LoginAccountRMC:8 sending msg: 0xa:14 LoginAccountRMC { data: LoginAccountData { email: "*****", password: "***" } } 14:44:31.153 DEBUG 14272 from_server::borderline::BorderlineMessage_LoginAccountRMR:65 received msg: 0xa:1e LoginAccountRMR { data: LoginAccountRMR { result: Success, warning_type: WarnNone, account: Some(LoginAccountResult { session: 4159, token: 13465866155329653453, character: Some(CNetWorldPlayerCompressedVO { guid: 2969, gold: 97093, name: "ERsanto", portrait: 379, border: 0, texture: 0, title: 6, state: 0, location: 0, map: NotAMap, experience: 82766, elo: 0, highest_elo: 0 }), bfp: 1778 }) } } 14:44:31.154 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetPlayerServerSettings: []" 14:44:31.154 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetPlayerServerSettingsRMC:55 sending msg: 0x1:2e GetPlayerServerSettingsRMC { request: 8 } 14:44:31.189 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetPlayerServerSettings: {"Debug":{"ForcedMapSeed":0,"ShowScriptGoals":false},"Gm":{"DoNotShowInRegion":false},"NotifyPromoDrop":1,"PreferredServer":"","PrivateLobbies":0,"ProfileVisibility":2,"ReceivePromoDropNotifications":2}" 14:44:31.190 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetServerTunables: []" 14:44:31.190 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetServerTunablesRMC:55 sending msg: 0x1:45 GetServerTunablesRMC { request: 9 } 14:44:31.274 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetServerTunables" 14:44:31.405 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetForgeThemes: []" 14:44:31.405 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetForgeThemesRMC:55 sending msg: 0x1:51 GetForgeThemesRMC { request: 10 } 14:44:31.431 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetForgeThemes: {"ErrorCode":0,"ForgeThemes":[{"Id":1,"IsOwned":true,"IsSeasonal":false,"SeasonEndMonth":0,"SeasonStartMonth":0},{"Id":2,"IsOwned":true,"IsSeasonal":true,"SeasonEndMonth":2,"SeasonStartMonth":12},{"Id":3,"IsOwned":false,"IsSeasonal":true,"SeasonEndMonth":5,"SeasonStartMonth":3},{"Id":4,"IsOwned":false,"IsSeasonal":true,"SeasonEndMonth":11,"SeasonStartMonth":6}]}" 14:44:31.431 INFO 18184 proxy::patches::changes::forge_map:23 forge map selected 14:44:31.434 DEBUG 14272 from_server::borderline::BorderlineMessage_LoginCharacterRMR:65 received msg: 0xa:19 LoginCharacterRMR 14:44:31.445 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetAllLimitedPoolsForCharacterRMC:14 sending msg: 0x7:f GetAllLimitedPoolsForCharacterRMC 14:44:31.470 DEBUG 14272 from_server::pregame::PreGameMessage_GetAllLimitedPoolsForCharacterRMR:49 received msg: 0x7:37 GetAllLimitedPoolsForCharacterRMR { error: 0, limited_pools: [LimitedPool { pool_id: 1, create_date: BFDateTime { index: 0, year: 2013, month: 10, day: 10, hour: 10, minute: 10, second: 10 }, close_date: BFDateTime { index: 0, year: 2043, month: 10, day: 10, hour: 10, minute: 10, second: 10 }, status: 0 }] } 14:44:31.480 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMC:14 sending msg: 0x7:26 GetAllCardsForCharacterCompressedRMC 14:44:31.553 DEBUG 14272 from_server::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMR:49 received msg: 0x7:4e GetAllCardsForCharacterCompressedRMR { cardpools: [CardPool { cards_size: 293, pool: 1, limited_pool_id: 0 }, CardPool { cards_size: 40, pool: 3, limited_pool_id: 1 }] } 14:44:31.553 INFO 14272 from_server::pregame::internal:737 Pool: 1, Limited pool id: 0 14:44:31.553 INFO 14272 from_server::pregame::internal:737 Pool: 2, Limited pool id: 0 14:44:31.553 INFO 14272 from_server::pregame::internal:737 Pool: 3, Limited pool id: 1 14:44:31.560 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMC:14 sending msg: 0x7:24 GetAllCardUpgradesForCharacterCompressedRMC 14:44:31.593 DEBUG 14272 from_server::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMR:49 received msg: 0x7:4c GetAllCardUpgradesForCharacterCompressedRMR { upgrades: Upgrades { upgrades_size: 184 } } 14:44:31.596 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetAllBoostersForCharacterRMC:14 sending msg: 0x7:21 GetAllBoostersForCharacterRMC 14:44:31.618 INFO 14272 from_server::pregame::PreGameMessage_GetAllBoostersForCharacterRMR:49 received msg: 0x7:49 GetAllBoostersForCharacterRMR 14:44:31.629 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetAllDecksForCharacterRMC:14 sending msg: 0x7:1c GetAllDecksForCharacterRMC 14:44:31.675 DEBUG 14272 from_server::pregame::PreGameMessage_GetAllDecksForCharacterRMR:49 received msg: 0x7:43 GetAllDecksForCharacterRMR { decks: Decks { decks_size: 8 } } 14:44:31.677 DEBUG 18184 proxy::bf_utils::fs::directory:48 Loaded 'C:\Users\gixer\OneDrive\Documents\BattleForge\\map\*.pak': 0 in files / 0 in paks 14:44:31.681 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile .\bf1\map\PVP\12601_PvP_02p_Skjal2.map doesn't exist!" 14:44:31.681 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile .\bf1\map\PVP\12601_PvP_02p_Skjal2.map doesn't exist! 14:44:31.682 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_1vs1 doesn't exist!" 14:44:31.682 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile UGM_DummyMap_1vs1 doesn't exist! 14:44:31.682 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_2vs2 doesn't exist!" 14:44:31.683 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile UGM_DummyMap_2vs2 doesn't exist! 14:44:31.683 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_1P doesn't exist!" 14:44:31.683 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile UGM_DummyMap_1P doesn't exist! 14:44:31.683 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_2P doesn't exist!" 14:44:31.683 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile UGM_DummyMap_2P doesn't exist! 14:44:31.683 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_4P doesn't exist!" 14:44:31.683 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile UGM_DummyMap_4P doesn't exist! 14:44:31.683 INFO 18184 proxy::logging:150 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_3vs3 doesn't exist!" 14:44:31.683 INFO 18184 proxy::logging::bf_exceptions:38 Exception: .?AVruntime_error@std@@: The mapfile UGM_DummyMap_3vs3 doesn't exist! 14:44:31.688 DEBUG 18184 proxy::bf_utils::fs::directory:48 Loaded '.\bf1\map\UG\*.map': 0 in files / 38 in paks 14:44:32.112 DEBUG 18184 proxy::bf_utils::fs::directory:48 Loaded '.\bf1\map\UG_Not_Shipped\*.map': 0 in files / 0 in paks 14:44:32.123 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetFinishedMapsForCharacterRMC:7 sending msg: 0x8:42 GetFinishedMapsForCharacterRMC 14:44:32.154 DEBUG 14272 from_server::matchmaking::MatchmakingMessage_GetFinishedMapsForCharacterRMR:16 received msg: 0x8:58 GetFinishedMapsForCharacterRMR { maps: [FinishedMap { id: 67, difficulty: 1 }, FinishedMap { id: 10, difficulty: 1 }, FinishedMap { id: 45, difficulty: 1 }, FinishedMap { id: 8, difficulty: 1 }, FinishedMap { id: 57, difficulty: 1 }, FinishedMap { id: 22, difficulty: 1 }, FinishedMap { id: 9, difficulty: 2 }, FinishedMap { id: 18, difficulty: 1 }, FinishedMap { id: 29, difficulty: 1 }, FinishedMap { id: 26, difficulty: 1 }, FinishedMap { id: 20, difficulty: 1 }, FinishedMap { id: 24, difficulty: 1 }, FinishedMap { id: 44, difficulty: 1 }, FinishedMap { id: 32, difficulty: 2 }, FinishedMap { id: 21, difficulty: 2 }, FinishedMap { id: 19, difficulty: 2 }, FinishedMap { id: 74, difficulty: 1 }, FinishedMap { id: 98, difficulty: 3 }, FinishedMap { id: 100, difficulty: 1 }, FinishedMap { id: 35, difficulty: 1 }, FinishedMap { id: 56, difficulty: 1 }, FinishedMap { id: 88, difficulty: 1 }, FinishedMap { id: 84, difficulty: 1 }, FinishedMap { id: 99, difficulty: 1 }] } 14:44:32.158 DEBUG 14272 sr_packet::from_game::world::WorldMessage_GetFriendListRMC:8 sending msg: 0x4:7b GetFriendListRMC 14:44:32.187 DEBUG 14272 from_server::world::WorldMessage_GetFriendListRMR:9 received msg: 0x4:4e GetFriendListRMR { friends: WorldPlayerCompressedListVO { player_count: 1 } } 14:44:32.193 DEBUG 14272 sr_packet::from_game::world::WorldMessage_GetIgnoreListRMC:8 sending msg: 0x4:78 GetIgnoreListRMC 14:44:32.216 DEBUG 14272 from_server::world::WorldMessage_GetIgnoreListRMR:9 received msg: 0x4:4b GetIgnoreListRMR { ignores: WorldPlayerCompressedListVO { player_count: 0 } } 14:44:32.226 DEBUG 14272 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 3, map: NotAMap } 14:44:32.250 DEBUG 14272 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 3, players: [] } 14:44:32.260 DEBUG 14272 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 4, map: NotAMap } 14:44:32.288 DEBUG 14272 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 4, players: [] } 14:44:32.294 DEBUG 14272 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 5, map: NotAMap } 14:44:32.331 DEBUG 14272 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 5, players: [] } 14:44:32.339 DEBUG 14272 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 6, map: NotAMap } 14:44:32.363 DEBUG 14272 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 6, players: [] } 14:44:32.373 DEBUG 14272 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 1, map: Introduction } 14:44:32.399 DEBUG 14272 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 1073, players: [CNetWorldPlayerCompressedVO { guid: 2969, gold: 0, name: "ERsanto", portrait: 379, border: 0, texture: 0, title: 6, state: 0, location: 0, map: Introduction, experience: 82766, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 118929, gold: 0, name: "diamondfindr", portrait: 5006, border: 0, texture: 0, title: 0, state: 0, location: 0, map: NotAMap, experience: 0, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 53796, gold: 0, name: "Bobzella", portrait: 1666, border: 0, texture: 0, title: 5, state: 0, location: 0, map: NotAMap, experience: 59563, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 99664, gold: 0, name: "DoctorDisco", portrait: 828, border: 23, texture: 0, title: 10, state: 0, location: 0, map: NotAMap, experience: 476134, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 118946, gold: 0, name: "4esan4o95", portrait: 1676, border: 8, texture: 0, title: 29, state: 0, location: 0, map: NotAMap, experience: 51872, elo: 104378, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 119009, gold: 0, name: "Abdusis", portrait: 5007, border: 0, texture: 0, title: 0, state: 0, location: 0, map: NotAMap, experience: 0, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 31036, gold: 0, name: "schinkenjim", portrait: 5051, border: 0, texture: 0, title: 0, state: 0, location: 0, map: NotAMap, experience: 2493752, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 4673, gold: 0, name: "dazero", portrait: 661, border: 13, texture: 1, title: 59, state: 0, location: 0, map: NotAMap, experience: 598935, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 48871, gold: 0, name: "Lokener", portrait: 1465, border: 0, texture: 0, title: 5, state: 0, location: 0, map: NotAMap, experience: 76523, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 75552, gold: 0, name: "Conee", portrait: 1128, border: 14, texture: 1, title: 10, state: 0, location: 0, map: NotAMap, experience: 568495, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 23803, gold: 0, name: "hunterBA", portrait: 1293, border: 0, texture: 0, title: 5, state: 0, location: 0, map: NotAMap, experience: 34533, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 36838, gold: 0, name: "Skinfaces", portrait: 5044, border: 14, texture: 2, title: 0, state: 0, location: 0, map: NotAMap, experience: 640388, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 36827, gold: 0, name: "Nerus87", portrait: 5064, border: 0, texture: 0, title: 7, state: 0, location: 0, map: NotAMap, experience: 133935, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 119010, gold: 0, name: "Opener", portrait: 5001, border: 0, texture: 0, title: 0, state: 0, location: 0, map: NotAMap, experience: 228, elo: 0, highest_elo: 0 }] } 14:44:32.407 DEBUG 14272 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 14:44:32.408 DEBUG 14272 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:8 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 1, state: 1, map: NotAMap } 14:44:32.605 TRACE 18184 proxy::patches::pvp_match:175 './bf1/map/sandbox\19000_Sandbox02\config\map_settings.json': Not found 14:44:32.605 TRACE 18184 proxy::patches::pvp_match:253 V1(JsonMapConfigV1 { map_end_tick: None, hide_pvp_map_end_timer: None, hide_pvp_map_score: None, on_draw_add_looping_extension_ticks: None, perform_draw_check_at_remaining_ticks_before_end: None, extension_ticks: None }) 14:44:32.615 INFO 18184 proxy::logging:150 src="Pathing" message="Init Pathing Engine: Path finding (Feb 21 2013/13:42:45) '_FINAL, _LIB, '" 14:44:32.617 INFO 18184 proxy::logging:150 src="Pathing.Manager" message="CPathManagerConstructed" 14:44:32.711 DEBUG 18184 proxy::patches::pvp_match:265 default? true 14:44:32.711 DEBUG 18184 proxy::patches::pvp_match:273 timer shown? true 14:44:32.711 DEBUG 18184 proxy::patches::pvp_match:281 score shown? true 14:44:32.712 DEBUG 18184 proxy::patches::pvp_match:306 match extending disable true 14:44:32.735 DEBUG 18184 proxy::game_config::get_set:24 debugmainmenu:stickyinfo = 14:44:32.736 INFO 18184 proxy::logging:150 src="VisManager" message="Loaded 4 different playercolors." 14:44:32.738 INFO 18184 proxy::logging:150 src="VisManager" message="Loaded 5 Flame Locator mappings" 14:44:32.738 INFO 18184 proxy::logging:150 src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 14:44:32.740 INFO 18184 proxy::logging:150 src="CVisSoundWorldPlugin" message="Loaded 3 Reverb settings, defaults to bf1/sound/ir_presets/default.ifr with dry level 0.030000" 14:44:32.758 INFO 18184 proxy::logging:150 src="VisMain" message="Starting Build Scene..." 14:44:33.571 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 1" 14:44:33.571 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:33.812 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:377] Online Mode initialize!" 14:44:33.812 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:158] Initialize Persistent Views" 14:44:33.814 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:64] PlayerListController:Update()" 14:44:33.814 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 14:44:33.814 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:74] show playerlist" 14:44:33.814 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 14:44:33.819 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:12] AddDelegates...PlayerListController..." 14:44:33.880 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:21] Initializing inventory controller." 14:44:33.880 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:47] Adding inventory controller delegates." 14:44:34.460 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:384] Toggling show inventory: 0" 14:44:34.461 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:392] Switching inventory tabs." 14:44:34.461 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:407] Switched to card tab." 14:44:34.462 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:151] Updating mode selection." 14:44:34.462 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:254] Attempting to select cardpool by dropdown item index: -1" 14:44:34.463 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:174] Cardpool found with id:1" 14:44:34.463 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:174] Cardpool found with id:2" 14:44:34.463 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:174] Cardpool found with id:3" 14:44:34.463 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:254] Attempting to select cardpool by dropdown item index: 0" 14:44:34.464 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:237] Updating inventory filter categories." 14:44:34.464 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:287] Resetting inventory filters." 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:229] Updated gold from 0 to 97093 and BFP from 0 to 1778" 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 0" 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 7" 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 6" 14:44:34.467 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:34.474 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:13] Initializing deck bar controller." 14:44:34.474 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:22] Initializing deck bar delegates." 14:44:34.480 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_eventwindow_controller.lub:17] EventWindowController...Initialize" 14:44:34.480 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_eventwindow_controller.lub:19] ...done" 14:44:34.480 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_eventwindow_controller.lub:30] EventWindowController:AddDelegates()" 14:44:34.488 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [timed_task_manager.lub:13] Created new task RefreshPlayerRegionList" 14:44:34.488 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_player_location_search_controller.lub:46] Initialize...PlayerLocationSearchController..." 14:44:34.488 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_player_location_search_controller.lub:126] InitializeScreen...PlayerLocationSearchController..." 14:44:34.542 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_player_location_search_controller.lub:62] PlayerLocationSearchController...AddDelegates..." 14:44:34.589 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:188] Checking for new mail ... checkServer=1" 14:44:34.589 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 sending msg: 0x7:14 GetInGameMailRMC 14:44:34.618 INFO 14272 from_server::pregame::PreGameMessage_GetInGameMailRMR:49 received msg: 0x7:3c GetInGameMailRMR 14:44:34.620 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:178] NavigationController.ActivateNewMailFX" 14:44:34.620 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:16] AddDelegates...NavigationController" 14:44:34.620 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:380] After Persistent Views initializing!" 14:44:34.621 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:224] SectionBrowser:SwitchSection to News" 14:44:34.621 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:245] SectionBrowser.CloseSectionBeforeSwitch: Closing section 'Login'" 14:44:34.621 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:259] SectionBrowser.SwitchSection: Opening section 'News'" 14:44:34.621 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:83] Creating view bf1/ui/dialogs/pregame/news/pg_news_view.xml" 14:44:34.705 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_leaderboard_controller.lub:24] LeaderboardController:__init()" 14:44:34.706 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:32] PregameSection.Open" 14:44:34.706 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:39] PregameSection.Open: Setting position on screen" 14:44:34.706 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:43] PregameSection.Open: Initialize controller" 14:44:34.716 DEBUG 14272 sr_packet::from_game::pregame::PreGameMessage_GetCharacterStatisticRMC:14 sending msg: 0x7:1e GetCharacterStatisticRMC 14:44:34.746 DEBUG 14272 from_server::pregame::PreGameMessage_GetCharacterStatisticRMR:49 received msg: 0x7:46 GetCharacterStatisticRMR { wins: [55, 3, 0, 22, 5, 0, 14, 15, 1, 3, 0, 0, 8, 0, 0, 1, 0, 0, 0, 1, 0, 0, 0, 0], stats: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0], cards: 479, elo: 0 } 14:44:34.748 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetQuestsAndAchievements: []" 14:44:34.748 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetQuestsAndAchievementsRMC:55 sending msg: 0x1:f GetQuestsAndAchievementsRMC { request: 11 } 14:44:34.748 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_news_controller.lub:270] NewsController:SwitchTab(1)" 14:44:34.748 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetIngameEventNews: {"Language":"en"}" 14:44:34.748 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetIngameEventNewsRMC:55 sending msg: 0x1:33 GetIngameEventNewsRMC { request: 12, language: "en" } 14:44:34.748 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_news_controller.lub:165] NewsController:Initialize() " 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:52] Show ActiveView" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:224] SectionBrowser:SwitchSection to News" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_inventory_view State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_playerlist_view State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_navigation_view State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_deck_bar_view State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_request_list_view State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_public_chatwindow_wnd State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_ls_playerlist_view State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:110] Hiding persistent View: pg_private_chatwindow_wnd State: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:124] Deckbuilder is ParentView" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:132] ShowPregameSections" 14:44:34.750 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 14:44:34.751 DEBUG 14272 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 14:44:34.751 DEBUG 14272 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:8 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:319] Deckbuilder Loaded!" 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:649] DeckBarController:OnPregame" 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:256] Attempt at toggling deckbar status. New status 1" 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:272] Did not toggle deckbar active status" 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:659] Inializing deck slots." 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:197] Current deck changed." 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:278] Deck changed to bad love story" 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:585] Attempting deck edit mode. New status 0" 14:44:34.754 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:597] Toggled deck edit mode. New status 0" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:287] Updating deck bar with deck bad love story" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:169] Updating lock deck button" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:215] Updating deck name" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:297] Resetting all card slots" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:223] Updating card slots" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:202] Updating cover card" 14:44:34.755 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:183] Updating new deck button" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:104] Set ExitBtnState 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:136] Change contacts button icon" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:128] We are in the sandbox and need to change PushButtonStates" 14:44:34.760 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:132] Set SectionsPushButton state 1" 14:44:34.779 WARN 14272 proxy::networking::connect:847 LOGIN: 3.8162157s 14:44:34.794 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetQuestsAndAchievements" 14:44:35.611 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetIngameEventNews" 14:44:36.315 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:224] SectionBrowser:SwitchSection to Forge" 14:44:36.315 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:245] SectionBrowser.CloseSectionBeforeSwitch: Closing section 'News'" 14:44:36.315 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:259] SectionBrowser.SwitchSection: Opening section 'Forge'" 14:44:36.315 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:385] Activate Deckbuiler" 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:124] Deckbuilder is ParentView" 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:136] HidePregameSections" 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 1" 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:36.317 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetComposedPvPDetails: []" 14:44:36.317 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetComposedPvPDetailsRMC:55 sending msg: 0x1:21 GetComposedPvPDetailsRMC { request: 13 } 14:44:36.340 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetComposedPvPDetails: {"CurrentDecks":[{"Guid":1.0,"Version":2.0},{"Guid":6.0,"Version":3.0}],"ErrorCode":1.0,"SecondsLeft":0.0}" 14:44:37.019 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:224] SectionBrowser:SwitchSection to GameWizard" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:245] SectionBrowser.CloseSectionBeforeSwitch: Closing section 'Forge'" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:394] DeActivate Deckbuiler" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:124] Deckbuilder is ParentView" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:132] ShowPregameSections" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:259] SectionBrowser.SwitchSection: Opening section 'GameWizard'" 14:44:37.020 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_game_section.lub:47] Initialize GameSection!" 14:44:37.021 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_screen_flow.lub:53] ScreenFlow:Next(bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml)" 14:44:37.021 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_screen_flow.lub:11] DoTransition: bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml" 14:44:37.021 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_screen_flow.lub:35] OnNextView! #0" 14:44:37.021 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:83] Creating view bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 16" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:32] PregameSection.Open" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:39] PregameSection.Open: Setting position on screen" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:43] PregameSection.Open: Initialize controller" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:11] WorldmapController...Initialize" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:13] ...done" 14:44:37.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:113] WorldmapController:AddDelegates()" 14:44:37.124 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:197] WorldmapController:InitializeHappyHourIndicator()" 14:44:37.125 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:207] WorldmapController:UpdateHappyHourIndicator(true)" 14:44:37.125 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:226] Hide worldmap happy hour indicator." 14:44:37.125 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:236] WorldmapController...Update..." 14:44:37.125 ERROR 18184 proxy::networking::connect:212 BUG, this should never happen, packet is already expected 14:44:37.129 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: true, map: NotAMap } 14:44:37.153 INFO 14272 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 received msg: 0x8:55 GetAllOpenCustomGamesRMR 14:44:37.162 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: NotAMap } 14:44:37.187 INFO 14272 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 received msg: 0x8:55 GetAllOpenCustomGamesRMR 14:44:37.229 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:52] Show ActiveView" 14:44:37.229 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:32] PregameSection.Open" 14:44:37.229 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:39] PregameSection.Open: Setting position on screen" 14:44:37.229 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:43] PregameSection.Open: Initialize controller" 14:44:37.229 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:11] WorldmapController...Initialize" 14:44:37.229 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:236] WorldmapController...Update..." 14:44:37.234 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: true, map: NotAMap } 14:44:37.256 INFO 14272 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 received msg: 0x8:55 GetAllOpenCustomGamesRMR 14:44:37.268 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: NotAMap } 14:44:37.297 INFO 14272 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 received msg: 0x8:55 GetAllOpenCustomGamesRMR 14:44:37.347 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section.lub:52] Show ActiveView" 14:44:37.354 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:321] WorldmapController...Refresh..." 14:44:37.354 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:236] WorldmapController...Update..." 14:44:37.360 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: true, map: NotAMap } 14:44:37.395 INFO 14272 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 received msg: 0x8:55 GetAllOpenCustomGamesRMR 14:44:37.406 DEBUG 14272 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: NotAMap } 14:44:37.432 INFO 14272 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 received msg: 0x8:55 GetAllOpenCustomGamesRMR 14:44:38.113 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:224] SectionBrowser:SwitchSection to Forge" 14:44:38.113 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:245] SectionBrowser.CloseSectionBeforeSwitch: Closing section 'GameWizard'" 14:44:38.121 DEBUG 14272 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 14:44:38.121 DEBUG 14272 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:8 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:259] SectionBrowser.SwitchSection: Opening section 'Forge'" 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:385] Activate Deckbuiler" 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:124] Deckbuilder is ParentView" 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:136] HidePregameSections" 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 14:44:38.122 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:10] ShowTutorial 1" 14:44:38.123 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_tutorial_helper.lub:39] Don't show tutorials, or tutorial already visited..." 14:44:38.123 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:92] Sending request Network_GetComposedPvPDetails: []" 14:44:38.123 DEBUG 14272 sr_packet::from_game::extensions::ExtensionCommands_GetComposedPvPDetailsRMC:55 sending msg: 0x1:21 GetComposedPvPDetailsRMC { request: 14 } 14:44:38.148 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: Received response Network_GetComposedPvPDetails: {"CurrentDecks":[{"Guid":1.0,"Version":2.0},{"Guid":6.0,"Version":3.0}],"ErrorCode":1.0,"SecondsLeft":0.0}" 14:44:40.424 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:574] Attempting to toggle inventory." 14:44:40.424 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:587] Can toggle because of correct sections. New inventory state:1" 14:44:40.424 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:384] Toggling show inventory: 1" 14:45:01.894 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:158] NavigationController:OpenIngameMenu" 14:45:01.898 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [event_listener.lub:36] Triggered EventListener with id 55" 14:45:01.898 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:64] SectionBrowser:OnOpenIngameOptions" 14:45:02.893 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_dialog_ingame_menu_controller.lub:20] NavigationController:OnExit" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:497] SectionBrowser:Exit..." 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:536] SectionBrowser.Close" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: UIEditor" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: News" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_widget_controller.lub:61] Calling a deprecated Method: WidgetController:Close" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: BoosterContent" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: OpenedBooster" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: Login" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: CompareProfile" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: CardReforge" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: CommandBuilder" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: CardUpgrade" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: Options" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: PlayersControlView" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: StoryBook" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: DeckCreation" 14:45:03.580 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: BoosterHistoryListEntry" 14:45:03.581 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: DirectTrade" 14:45:03.581 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: GameWizard" 14:45:03.581 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:499] WorldmapController...Close..." 14:45:03.581 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:501] ...RemoveAllDelegates" 14:45:03.581 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_worldmap_controller_new.lub:158] WorldmapController:RemoveAllDelegates()" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: Marketplace" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: DeckControl" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: ShowDeck" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: Mail" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: Replays" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: BoosterHistory" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_section_browser.lub:538] Destroying Section: Forge" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:42] Inventory controller: Close" 14:45:03.582 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_inventory_controller.lub:107] Removing inventory controller delegates." 14:45:03.584 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:56] PlayerListController...Close..." 14:45:03.584 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:58] ...RemoveAllDelegates" 14:45:03.584 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_playerlist_controller.lub:36] RemoveAllDelegates...PlayerListController..." 14:45:03.588 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_navigation_controller.lub:58] RemoveAllDelegates...NavigationController" 14:45:03.589 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:139] Deck bar closed. Saving current deck and removing delegates" 14:45:03.589 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_deck_bar_controller.lub:83] Removing deck bar delegates." 14:45:03.591 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_widget_controller.lub:61] Calling a deprecated Method: WidgetController:Close" 14:45:03.593 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_public_chatwindow_controller.lub:45] Successfully closed PublicChatWindowController." 14:45:03.593 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_player_location_search_controller.lub:118] PlayerLocationSearchController...Close..." 14:45:03.593 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_player_location_search_controller.lub:95] PlayerLocationSearchController...RemoveAllDelegates..." 14:45:03.595 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_private_chatwindow_controller.lub:38] Successfully closed PrivateChatWindowController." 14:45:03.595 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_eventwindow_controller.lub:194] EventWindowController...Close..." 14:45:03.595 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_eventwindow_controller.lub:196] ...RemoveAllDelegates" 14:45:03.595 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_eventwindow_controller.lub:76] EventWindowController:RemoveAllDelegates()" 14:45:03.600 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_notification_listener.lub:195] Removing notification listener..." 14:45:03.600 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_notification_listener.lub:197] Notification listener removed!" 14:45:03.600 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:121] Removing packet listener..." 14:45:03.601 INFO 18184 proxy::logging:150 src="UI (Lua)" message="[=?]: [pg_packet_listener.lub:123] Packet listener removed!" 14:45:03.601 INFO 18184 proxy::networking::connect:305 destroying 14:45:03.601 INFO 18184 proxy::networking::open_ssl_wrapper:173 disconnecting 14:45:03.601 ERROR 14272 proxy::networking::connect:422 FP->S no msg 14:45:03.601 INFO 18184 proxy::networking::open_ssl_wrapper:188 disconnected 14:45:03.601 ERROR 14272 proxy::networking::connect:404 P->BF no msg 14:45:03.602 INFO 18184 proxy::networking::connect:307 destroyed