17:57:45.541 WARN 9084 proxy:78 
proxy from 2020-09-07T11:26:10.324607Z is initializing 
	17:57:45.542 INFO 9084 proxy::networking::connect:181 
connect disconnect hooks initialized 
	17:57:45.543 INFO 9084 proxy::networking:69 
networking hooks initialized 
	17:57:45.543 WARN 9084 proxy:102 
Initialized successfully 
	17:57:45.802 WARN 9084 proxy::game_config:307 
application:maxshader 'false' is not a int 
	17:57:45.812 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Start Scan" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Found Adapter: NVIDIA GeForce GTX 1070" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Support Hardware vertex processing" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Support SM 3.0" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Found Adapter: NVIDIA GeForce GTX 1070" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Support Hardware vertex processing" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="Support SM 3.0" 
	17:57:45.839 INFO 9084 proxy::logging:72 
src="Direct3D 9" message="End Scan" 
	17:57:45.840 INFO 9084 proxy::logging:72 
src="Direct3D 11" message="Start DXGI scan." 
	17:57:45.843 INFO 9084 proxy::logging:72 
src="Direct3D 11" message="Found Adapter: NVIDIA GeForce GTX 1070" 
	17:57:45.916 INFO 9084 proxy::logging:72 
src="Direct3D 11" message="Supports Techlevel 11.0" 
	17:57:45.916 INFO 9084 proxy::logging:72 
src="Direct3D 11" message="Found Adapter: NVIDIA GeForce GTX 1070" 
	17:57:45.952 INFO 9084 proxy::logging:72 
src="Direct3D 11" message="Supports Techlevel 11.0" 
	17:57:45.952 INFO 9084 proxy::logging:72 
src="Direct3D 11" message="End DXGI scan." 
	17:57:45.955 INFO 9084 proxy::logging:72 
src="app" message="BattleForge Final Build: 400007 (Retail branch)" 
	17:57:45.955 INFO 9084 proxy::logging:72 
src="app" message="CPU AuthenticAMD family un detected." 
	17:57:46.352 INFO 9084 proxy::logging:72 
src="app" message="CPU clock speed is ~3593 MHz." 
	17:57:46.352 INFO 9084 proxy::logging:72 
src="app" message="CPU has 4 cores." 
	17:57:46.353 INFO 9084 proxy::logging:72 
src="app" message="CPU rating is 0 points." 
	17:57:46.353 INFO 9084 proxy::logging:72 
src="app" message="GFX rating is 0 points." 
	17:57:46.353 INFO 9084 proxy::logging:72 
src="CreateDisplay" message="Creating Display DirectX 11" 
	17:57:46.377 INFO 9084 proxy::logging:72 
src="Create Device" message="Use Direct3D 11" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Vendor ID = 0x10de" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Device ID = 0x1b81" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Subsystem ID = 0x85971043" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Revision = 0xa1" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Device description = NVIDIA GeForce GTX 1070" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Video Memory = -1073741824" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="System Memory = 0" 
	17:57:46.378 INFO 9084 proxy::logging:72 
src="GPU" message="Shared Memory = 1073676288" 
	17:57:46.391 WARN 9084 proxy::logging:73 
src="Direct3D 11" message="Create shader resource view : S_OK" 
	17:57:46.768 WARN 9084 proxy::game_config:516 
application:lowqualitysounds '"0"' is not a bool 
	17:57:46.773 INFO 9084 proxy::logging:72 
src="PssSoundPipeline" message="Loading soundpipeline:\n\n Version: 1\nNumber of Files:9604" 
	17:57:47.049 INFO 9084 proxy::logging:72 
src="PssSoundPipeline" message="Loading soundpipeline bf1/sound/SoundPipeline_en.bin finished, 38471.48 seconds of music material in pipe." 
	17:57:47.115 INFO 9084 proxy::logging:72 
src="CPssPhysicalRenderer" message="Got Stereo speakers!" 
	17:57:47.325 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 4 different playercolors." 
	17:57:47.326 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 5 Flame Locator mappings" 
	17:57:47.326 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 
	17:57:48.320 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [timed_task_manager.lub:15] Created new anonymous task" 
	17:57:48.350 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [event_listener.lub:20] Register EventListener with id 55" 
	17:57:48.609 WARN 9084 proxy::game_config:516 
vismain:optionshadowmap '"0"' is not a bool 
	17:57:48.610 WARN 9084 proxy::game_config:321 
vismain:optionshadowmapfilter '"0"' is not a int 
	17:57:48.610 WARN 9084 proxy::game_config:516 
vismain:optionshadowobjects '"0"' is not a bool 
	17:57:48.610 WARN 9084 proxy::game_config:516 
vismain:optionenablecloudshadow '"0"' is not a bool 
	17:57:48.610 WARN 9084 proxy::game_config:418 
vismain:optiontexturesizebias '"0"' is not a float 
	17:57:48.610 WARN 9084 proxy::game_config:321 
vismain:optionshaderlod '"0"' is not a int 
	17:57:48.610 WARN 9084 proxy::game_config:516 
vismain:optionenableglow '"0"' is not a bool 
	17:57:48.610 WARN 9084 proxy::game_config:321 
fxbudgetmanager:quality '"0"' is not a int 
	17:57:48.610 WARN 9084 proxy::game_config:516 
application:lowqualitysounds '"0"' is not a bool 
	17:57:48.702 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Login" 
	17:57:48.702 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Login\'" 
	17:57:48.702 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_screen_flow.lub:52] ScreenFlow:Next(bf1/ui/dialogs/pregame/login/pg_login_view.xml)" 
	17:57:48.702 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_screen_flow.lub:10] DoTransition: bf1/ui/dialogs/pregame/login/pg_login_view.xml" 
	17:57:48.702 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_screen_flow.lub:34] OnNextView! #0" 
	17:57:48.702 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/login/pg_login_view.xml" 
	17:57:48.908 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [timed_task_manager.lub:12] Created new task ReEnableLogin" 
	17:57:48.909 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:30] PregameSection.Open" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:50] Show ActiveView" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:30] PregameSection.Open" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:57:48.910 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:01] [pg_section.lub:50] Show ActiveView" 
	17:58:06.813 INFO 9084 proxy::networking::connect:248 
connecting 
	17:58:06.813 INFO 9084 proxy::networking::connect:297 
forge_connect 
	17:58:06.923 INFO 9084 proxy::networking::connect:339 
connected TlsStream { io: TcpStream, session: ClientSession { imp: ClientSessionImpl }, state: Stream } 
	17:58:06.923 INFO 9084 proxy::networking::connect:253 
fully connected 
	17:58:06.948 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:19] [pg_notification_listener.lub:150] Adding Notification listener..." 
	17:58:06.948 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:19] [pg_notification_listener.lub:152] Notification listener added!" 
	17:58:06.948 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:19] [pg_packet_listener.lub:149] Adding Packet listener..." 
	17:58:06.948 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:19] [pg_packet_listener.lub:151] Packet listener added!" 
	17:58:06.968 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:06.968 DEBUG 8556 sr_packet::from_game::borderline::BorderlineMessage_LoginAccountRMC:8 
sending msg: 0xa:14 LoginAccountRMC { data: LoginAccountData { email: "****", password: "***" } } 
	17:58:07.167 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:07.256 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:07.256 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:07.256 DEBUG 8556 from_server::borderline::BorderlineMessage_LoginAccountRMR:64 
received msg: 0xa:1e LoginAccountRMR { data: LoginAccountRMR { result: Success, warning_type: WarnNone, account: Some(LoginAccountResult { session: 815, token: 5828377345408332181, character: Some(CNetWorldPlayerCompressedVO { guid: 57249, gold: 105, name: "Kimahri1980", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -23 } }, state: 0, location: 0, map: NotAMap, experience: 674, elo: 0, highest_elo: 0 }), bfp: 334 }) } } 
	17:58:07.257 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:20] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{18}\u{8}" 
	17:58:07.257 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:20] [pg_packet_listener.lub:133] Request with id 8 was sent!" 
	17:58:07.265 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:07.265 DEBUG 8556 sr_packet::from_game::extensions::ExtensionCommands_CustomPacket:16 
sending msg: 0x1:1 CustomPacket { lua_data: "\u{18}\u{8}" } 
	17:58:07.313 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:07.402 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:07.402 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:07.402 DEBUG 8556 from_server::chat::ChatMessage_SystemNotification:8 
received msg: 0x6:b SystemNotification { message: "\u{1}\u{8}\u{0}\u{0}{}" } 
	17:58:07.402 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:20] [pg_packet_listener.lub:65] Header:8|1|1" 
	17:58:07.402 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:20] [pg_packet_listener.lub:66] Data:{}" 
	17:58:07.402 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:20] [pg_packet_listener.lub:74] Received all request packets for request 8" 
	17:58:07.402 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:20] [pg_packet_listener.lub:75] Combined data: {}" 
	17:58:07.408 DEBUG 8556 from_server::borderline::BorderlineMessage_LoginCharacterRMR:64 
received msg: 0xa:19 LoginCharacterRMR 
	17:58:07.418 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllLimitedPoolsForCharacterRMR:9 
received msg: 0x7:37 GetAllLimitedPoolsForCharacterRMR 
	17:58:07.430 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:07.430 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMC:14 
sending msg: 0x7:26 GetAllCardsForCharacterCompressedRMC 
	17:58:07.494 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:07.544 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:07.544 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:07.544 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMR:9 
received msg: 0x7:4e GetAllCardsForCharacterCompressedRMR { cards: CardsCompressed { cards_size: 56 } } 
	17:58:07.551 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:07.551 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMC:14 
sending msg: 0x7:24 GetAllCardUpgradesForCharacterCompressedRMC 
	17:58:07.602 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:07.688 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:07.688 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:07.688 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMR:9 
received msg: 0x7:4c GetAllCardUpgradesForCharacterCompressedRMR { upgrades: Upgrades { upgrades_size: 2 } } 
	17:58:07.694 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:07.694 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllBoostersForCharacterRMC:14 
sending msg: 0x7:21 GetAllBoostersForCharacterRMC 
	17:58:07.743 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:07.830 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:07.830 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:07.830 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllBoostersForCharacterRMR:9 
received msg: 0x7:49 GetAllBoostersForCharacterRMR { boosters: [] } 
	17:58:07.837 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:07.837 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllDecksForCharacterRMC:14 
sending msg: 0x7:1c GetAllDecksForCharacterRMC 
	17:58:07.901 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:07.988 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:07.988 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:07.988 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllDecksForCharacterRMR:9 
received msg: 0x7:43 GetAllDecksForCharacterRMR { decks: Decks { decks_size: 2 } } 
	17:58:07.995 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile .\\bf1\\map\\PVP\\12601_PvP_02p_Skjal2.map doesn\'t exist!" 
	17:58:07.996 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_1vs1 doesn\'t exist!" 
	17:58:07.996 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_2vs2 doesn\'t exist!" 
	17:58:07.996 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_1P doesn\'t exist!" 
	17:58:07.997 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_2P doesn\'t exist!" 
	17:58:07.997 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_4P doesn\'t exist!" 
	17:58:07.997 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_3vs3 doesn\'t exist!" 
	17:58:08.452 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:08.452 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetFinishedMapsForCharacterRMC:7 
sending msg: 0x8:42 GetFinishedMapsForCharacterRMC 
	17:58:08.506 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:08.593 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:08.593 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:08.593 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetFinishedMapsForCharacterRMR:16 
received msg: 0x8:58 GetFinishedMapsForCharacterRMR { maps: [FinishedMap { id: 67, difficulty: 1 }, FinishedMap { id: 45, difficulty: 1 }] } 
	17:58:08.595 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:08.595 DEBUG 8556 sr_packet::from_game::world::WorldMessage_GetFriendListRMC:7 
sending msg: 0x4:7b GetFriendListRMC 
	17:58:08.643 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:08.731 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:08.731 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:08.731 DEBUG 8556 from_server::world::WorldMessage_GetFriendListRMR:9 
received msg: 0x4:4e GetFriendListRMR { friends: [] } 
	17:58:08.738 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:08.738 DEBUG 8556 sr_packet::from_game::world::WorldMessage_GetIgnoreListRMC:7 
sending msg: 0x4:78 GetIgnoreListRMC 
	17:58:08.794 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:08.881 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:08.881 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:08.881 DEBUG 8556 from_server::world::WorldMessage_GetIgnoreListRMR:9 
received msg: 0x4:4b GetIgnoreListRMR { ignores: [] } 
	17:58:08.892 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:08.892 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 
sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 3, map: NotAMap } 
	17:58:08.940 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:09.028 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:09.028 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:09.028 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionRMR:8 
received msg: 0x6:1b JoinChatRegionRMR { channel: 3, players: [] } 
	17:58:09.035 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:09.035 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 
sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 4, map: NotAMap } 
	17:58:09.084 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:09.172 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:09.172 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:09.172 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionRMR:8 
received msg: 0x6:1b JoinChatRegionRMR { channel: 4, players: [] } 
	17:58:09.178 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:09.178 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 
sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 5, map: NotAMap } 
	17:58:09.227 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:09.314 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:09.314 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:09.314 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionRMR:8 
received msg: 0x6:1b JoinChatRegionRMR { channel: 5, players: [] } 
	17:58:09.321 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:09.321 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 
sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 6, map: NotAMap } 
	17:58:09.373 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:09.463 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:09.463 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:09.463 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionRMR:8 
received msg: 0x6:1b JoinChatRegionRMR { channel: 6, players: [] } 
	17:58:09.464 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:09.464 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 
sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 1, map: Introduction } 
	17:58:09.515 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:09.604 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:09.604 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:09.604 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:09.604 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionRMR:8 
received msg: 0x6:1b JoinChatRegionRMR { channel: 1073, players: [JoinChatRegionPlayer { player: 46596, rank: 0, name: "S3x0B3atz" }, JoinChatRegionPlayer { player: 49012, rank: 0, name: "Lensver04" }, JoinChatRegionPlayer { player: 43480, rank: 0, name: "Spik" }, JoinChatRegionPlayer { player: 4613, rank: 0, name: "Bini_Inibitor" }, JoinChatRegionPlayer { player: 57245, rank: 0, name: "Scrof" }, JoinChatRegionPlayer { player: 57268, rank: 0, name: "Wuzzoh" }, JoinChatRegionPlayer { player: 57269, rank: 0, name: "Slusho" }, JoinChatRegionPlayer { player: 55935, rank: 0, name: "Donaar" }, JoinChatRegionPlayer { player: 18472, rank: 0, name: "Anton" }, JoinChatRegionPlayer { player: 6681, rank: 0, name: "ducarev" }, JoinChatRegionPlayer { player: 42864, rank: 0, name: "JarodDempsey" }, JoinChatRegionPlayer { player: 51621, rank: 0, name: "Doriki" }, JoinChatRegionPlayer { player: 35176, rank: 0, name: "Jofko" }, JoinChatRegionPlayer { player: 57154, rank: 0, name: "Timmy30" }, JoinChatRegionPlayer { player: 11886, rank: 0, name: "MyLyrics" }, JoinChatRegionPlayer { player: 56815, rank: 0, name: "Draccu" }, JoinChatRegionPlayer { player: 57249, rank: 0, name: "Kimahri1980" }] } 
	17:58:09.604 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 
received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 57249, gold: 105, name: "Kimahri1980", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -23 } }, state: 0, location: 0, map: Introduction, experience: 674, elo: 0, highest_elo: 0 } } 
	17:58:09.608 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:58:09.608 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:09.608 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 1, state: 1, map: NotAMap } 
	17:58:10.148 INFO 9084 proxy::logging:72 
src="Pathing" message="Init Pathing Engine: Path finding (Feb 21 2013/13:42:45) \'_FINAL, _LIB, \'" 
	17:58:10.150 INFO 9084 proxy::logging:72 
src="Pathing.Manager" message="CPathManagerConstructed" 
	17:58:10.602 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 4 different playercolors." 
	17:58:10.604 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 5 Flame Locator mappings" 
	17:58:10.604 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 
	17:58:10.608 INFO 9084 proxy::logging:72 
src="CVisSoundWorldPlugin" message="Loaded 3 Reverb settings, defaults to bf1/sound/ir_presets/default.ifr with dry level 0.030000" 
	17:58:10.624 WARN 9084 proxy::game_config:516 
vismain:optionshadowmap '"0"' is not a bool 
	17:58:10.624 WARN 9084 proxy::game_config:321 
vismain:optionshadowmapfilter '"0"' is not a int 
	17:58:10.624 WARN 9084 proxy::game_config:516 
vismain:optionshadowobjects '"0"' is not a bool 
	17:58:10.624 WARN 9084 proxy::game_config:418 
vismain:optiontexturesizebias '"0"' is not a float 
	17:58:10.624 WARN 9084 proxy::game_config:516 
vismain:optionenableglow '"0"' is not a bool 
	17:58:10.624 WARN 9084 proxy::game_config:516 
vismain:optionenablecloudshadow '"0"' is not a bool 
	17:58:10.624 WARN 9084 proxy::game_config:321 
vismain:optionshaderlod '"0"' is not a int 
	17:58:10.632 INFO 9084 proxy::logging:72 
src="VisMain" message="Starting Build Scene..." 
	17:58:13.274 WARN 9084 proxy::game_config:321 
fxbudgetmanager:quality '"0"' is not a int 
	17:58:14.401 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:10] ShowTutorial 1" 
	17:58:14.401 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:58:14.844 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_section_browser.lub:275] Online Mode initialize!" 
	17:58:14.844 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_section_browser.lub:158] Initialize Persistent Views" 
	17:58:14.846 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 
	17:58:14.847 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 
	17:58:14.847 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_playerlist_controller.lub:74] show playerlist" 
	17:58:14.847 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 
	17:58:14.897 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_playerlist_controller.lub:12] AddDelegates...PlayerListController..." 
	17:58:15.108 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:35] Initializing inventory controller." 
	17:58:15.108 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:59] Adding inventory controller delegates." 
	17:58:15.352 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:341] Toggling show inventory: 0" 
	17:58:15.352 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:349] Switching inventory tabs." 
	17:58:15.352 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:363] Switched to card tab." 
	17:58:15.356 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:163] Updating mode selection." 
	17:58:15.356 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 
	17:58:15.357 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:185] Cardpool found with id:1" 
	17:58:15.357 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:185] Cardpool found with id:2" 
	17:58:15.357 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:245] Updating inventory filter categories." 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:297] Resetting inventory filters." 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.358 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:10] ShowTutorial 0" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:10] ShowTutorial 7" 
	17:58:15.359 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 
	17:58:15.360 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:46] ...adding position" 
	17:58:15.392 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 
	17:58:15.392 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:10] ShowTutorial 6" 
	17:58:15.392 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:58:15.421 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_deck_bar_controller.lub:13] Initializing deck bar controller." 
	17:58:15.421 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_deck_bar_controller.lub:22] Initializing deck bar delegates." 
	17:58:15.448 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_eventwindow_controller.lub:16] EventWindowController...Initialize" 
	17:58:15.448 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_eventwindow_controller.lub:18] ...done" 
	17:58:15.448 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_eventwindow_controller.lub:29] EventWindowController:AddDelegates()" 
	17:58:15.482 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [timed_task_manager.lub:12] Created new task RefreshPlayerRegionList" 
	17:58:15.482 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_player_location_search_controller.lub:46] Initialize...PlayerLocationSearchController..." 
	17:58:15.482 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_player_location_search_controller.lub:126] InitializeScreen...PlayerLocationSearchController..." 
	17:58:15.543 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_player_location_search_controller.lub:62] PlayerLocationSearchController...AddDelegates..." 
	17:58:15.697 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:25] [pg_navigation_controller.lub:189] Checking for new mail ... checkServer=1" 
	17:58:15.705 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:15.705 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 
sending msg: 0x7:14 GetInGameMailRMC 
	17:58:15.761 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:15.848 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:15.848 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:15.848 DEBUG 8556 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 
received msg: 0x7:3c GetInGameMailRMR { mails: [Mail { id: 6866033, sender: None, header: "", body: "{\"ID\":1,\"Tag\": \"QuestComplete\",\"Data\": [6]}", cards: [], mail_type: 1, boosters: [], creation_date: 1599425590, gold: 0, type_: 2, bfp: 75, collected: true, auction_card: "No card", auction_bfp: 0 }, Mail { id: 6866034, sender: None, header: "", body: "{\"ID\":1,\"Tag\": \"QuestComplete\",\"Data\": [1]}", cards: [], mail_type: 1, boosters: [], creation_date: 1599425590, gold: 0, type_: 2, bfp: 0, collected: true, auction_card: "No card", auction_bfp: 0 }, Mail { id: 6869923, sender: None, header: "", body: "{\"ID\":1,\"Tag\": \"QuestComplete\",\"Data\": [3]}", cards: [], mail_type: 1, boosters: [], creation_date: 1599500050, gold: 0, type_: 1, bfp: 75, collected: false, auction_card: "No card", auction_bfp: 0 }] } 
	17:58:15.850 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 
	17:58:15.854 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:16] AddDelegates...NavigationController" 
	17:58:15.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:278] After Persistent Views initializing!" 
	17:58:15.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to News" 
	17:58:15.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Login\'" 
	17:58:15.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'News\'" 
	17:58:15.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/news/pg_news_view.xml" 
	17:58:16.042 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section.lub:30] PregameSection.Open" 
	17:58:16.042 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:58:16.042 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:58:16.045 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:16.046 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetCharacterStatisticRMC:14 
sending msg: 0x7:1e GetCharacterStatisticRMC 
	17:58:16.101 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:16.189 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:16.189 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:16.189 DEBUG 8556 from_server::pregame::PreGameMessage_GetCharacterStatisticRMR:9 
received msg: 0x7:46 GetCharacterStatisticRMR { wins: [2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 3, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0], stats: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0], cards: 58, elo: 0 } 
	17:58:16.223 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{f}\t0" 
	17:58:16.223 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:133] Request with id 9 was sent!" 
	17:58:16.223 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:586] NewsController:SwitchTab(2)" 
	17:58:16.223 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:184] NewsController:Initialize() " 
	17:58:16.224 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section.lub:50] Show ActiveView" 
	17:58:16.224 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to News" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [timed_task_manager.lub:15] Created new anonymous task" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_inventory_view State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_playerlist_view State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_navigation_view State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_deck_bar_view State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_request_list_view State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_public_chatwindow_wnd State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_ls_playerlist_view State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:110] Hiding persistent View: pg_private_chatwindow_wnd State: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:124] Deckbuilder is ParentView" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:132] ShowPregameSections" 
	17:58:16.225 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 
	17:58:16.233 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:16.233 DEBUG 8556 sr_packet::from_game::extensions::ExtensionCommands_GetQuests:16 
sending msg: 0x1:f GetQuests { request: 9, language: 48 } 
	17:58:16.233 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:16.233 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 
	17:58:16.233 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:58:16.234 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_section_browser.lub:264] Deckbuilder Loaded!" 
	17:58:16.234 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:650] DeckBarController:OnPregame" 
	17:58:16.234 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:257] Attempt at toggling deckbar status. New status 1" 
	17:58:16.234 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:273] Did not toggle deckbar active status" 
	17:58:16.234 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:660] Inializing deck slots." 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_inventory_controller.lub:212] Current deck changed." 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:279] Deck changed to FrostNature" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:598] Toggled deck edit mode. New status 0" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:288] Updating deck bar with deck FrostNature" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:215] Updating deck name" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:298] Resetting all card slots" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:223] Updating card slots" 
	17:58:16.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:202] Updating cover card" 
	17:58:16.244 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_deck_bar_controller.lub:183] Updating new deck button" 
	17:58:16.286 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:16.336 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:16.336 TRACE 8556 sr_packet::from_game::extensions:114 
Splitting packet to 2 parts 
	17:58:16.336 WARN 8556 proxy::networking::connect:810 
LOGIN: 9.4123964s 
	17:58:16.336 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:16.336 DEBUG 8556 from_server::chat::ChatMessage_SystemNotification:8 
received msg: 0x6:b SystemNotification { message: "\u{1}\t\u{0}\u{1}{\"Achievements\":[{\"CanBeRerolled\":false,\"Goal\":3.0,\"Id\":1.0,\"Progress\":2.0,\"RewardBFP\":0.0,\"RewardBooster\":1.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"NextQuestIn\":57720.0,\"Quests\":[{\"CanBeRerolled\":true,\"Goal\":4.0,\"Id\":5.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":2.0,\"Id\":6.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":2.0,\"Id\":8.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":1.0,\"Id\":11.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":7.0,\"Id\":4.0,\"Progress\":5.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCar" } 
	17:58:16.336 DEBUG 8556 from_server::chat::ChatMessage_SystemNotification:8 
received msg: 0x6:b SystemNotification { message: "\u{1}\t\u{1}\u{1}ds\":[],\"RewardXP\":0.0}],\"ReRollAvailable\":true,\"TimeRewards\":{\"DailyBoost\":217.0,\"DailyBoostPlayTimeLeft\":2955.0,\"Reserve\":200.0}}" } 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:105] Set ExitBtnState 1" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:137] Change contacts button icon" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.393 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:65] Header:9|1|2" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:66] Data:{\"Achievements\":[{\"CanBeRerolled\":false,\"Goal\":3.0,\"Id\":1.0,\"Progress\":2.0,\"RewardBFP\":0.0,\"RewardBooster\":1.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"NextQuestIn\":57720.0,\"Quests\":[{\"CanBeRerolled\":true,\"Goal\":4.0,\"Id\":5.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":2.0,\"Id\":6.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":2.0,\"Id\":8.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":1.0,\"Id\":11.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":7.0,\"Id\":4.0,\"Progress\":5.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCar" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:65] Header:9|2|2" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:66] Data:ds\":[],\"RewardXP\":0.0}],\"ReRollAvailable\":true,\"TimeRewards\":{\"DailyBoost\":217.0,\"DailyBoostPlayTimeLeft\":2955.0,\"Reserve\":200.0}}" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:74] Received all request packets for request 9" 
	17:58:16.394 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_packet_listener.lub:75] Combined data: {\"Achievements\":[{\"CanBeRerolled\":false,\"Goal\":3.0,\"Id\":1.0,\"Progress\":2.0,\"RewardBFP\":0.0,\"RewardBooster\":1.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"NextQuestIn\":57720.0,\"Quests\":[{\"CanBeRerolled\":true,\"Goal\":4.0,\"Id\":5.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":2.0,\"Id\":6.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":2.0,\"Id\":8.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":1.0,\"Id\":11.0,\"Progress\":0.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"CanBeRerolled\":true,\"Goal\":7.0,\"Id\":4.0,\"Progress\":5.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"ReRollAvailable\":true,\"TimeRewards\":{\"DailyBoost\":217.0,\"DailyBoostPlayTimeLeft\":2955.0,\"Reserve\":200.0}}" 
	17:58:16.417 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 1" 
	17:58:16.440 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 5" 
	17:58:16.465 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 6" 
	17:58:16.478 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 8" 
	17:58:16.489 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 11" 
	17:58:16.501 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:26] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 4" 
	17:58:18.598 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 
	17:58:18.598 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'News\'" 
	17:58:18.598 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 
	17:58:18.598 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:293] Activate Deckbuiler" 
	17:58:18.600 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 
	17:58:18.600 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:124] Deckbuilder is ParentView" 
	17:58:18.600 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:136] HidePregameSections" 
	17:58:18.600 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 
	17:58:18.600 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_tutorial_helper.lub:10] ShowTutorial 1" 
	17:58:18.600 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:29] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Mail" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:302] DeActivate Deckbuiler" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:124] Deckbuilder is ParentView" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:132] ShowPregameSections" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Mail\'" 
	17:58:21.768 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/mail/pg_mail_view.xml" 
	17:58:21.901 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:10] ShowTutorial 42" 
	17:58:21.901 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 
	17:58:21.901 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:46] ...adding position" 
	17:58:21.903 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 
	17:58:21.903 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:10] ShowTutorial 43" 
	17:58:21.903 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 
	17:58:21.903 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:46] ...adding position" 
	17:58:21.904 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 
	17:58:21.904 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section.lub:30] PregameSection.Open" 
	17:58:21.904 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:58:21.904 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:58:21.904 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:37] Initializing mail controller." 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:894] Clearing mail text input fields." 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:886] Updating mail text input fields with latest values." 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:338] Attempting to switch to screen 1" 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:350] Switched to mail inbox tab." 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:237] Updating mail inbox." 
	17:58:21.905 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:240] Fetched mails from server." 
	17:58:21.922 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:1" 
	17:58:21.945 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2" 
	17:58:21.949 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2" 
	17:58:21.951 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:21.951 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:224] Inventory updated." 
	17:58:21.951 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:163] Updating mode selection." 
	17:58:21.951 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 
	17:58:21.952 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:185] Cardpool found with id:1" 
	17:58:21.952 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:185] Cardpool found with id:2" 
	17:58:21.952 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:21.953 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:21.953 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 
	17:58:21.953 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:58:21.953 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 
	17:58:21.953 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:288] Updating deck bar with deck FrostNature" 
	17:58:21.953 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:215] Updating deck name" 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:298] Resetting all card slots" 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:223] Updating card slots" 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_deck_bar_controller.lub:202] Updating cover card" 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:162] Updating mail attachments." 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:21.954 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_mail_controller.lub:886] Updating mail text input fields with latest values." 
	17:58:21.955 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:32] [pg_section.lub:50] Show ActiveView" 
	17:58:24.188 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:34] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:29.688 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:40] [pg_tutorial_helper.lub:96] Tutorial Aborted: 42" 
	17:58:31.487 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:41] [pg_tutorial_helper.lub:84] Tutorial Visited: 42" 
	17:58:33.438 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:43] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:33.438 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:43] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:34.156 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:44] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:34.156 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:44] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:35.611 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:35.611 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:35.783 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:395] Reading a mail..." 
	17:58:35.783 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:35.783 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:463] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:1 Cards:0 Boosters:0 BFP:75" 
	17:58:35.783 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:222] Attempting to disable new mail FX" 
	17:58:35.783 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:217] Unread mail count is 1" 
	17:58:35.784 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:338] Attempting to switch to screen 3" 
	17:58:35.784 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:35.784 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:46] [pg_mail_controller.lub:386] Switched to read mail tab." 
	17:58:37.878 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:48] [pg_mail_controller.lub:510] Trying to collect items from mail:0 CollectedOnDelete:0" 
	17:58:37.878 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:48] [pg_mail_controller.lub:518] Mail had attachments. Attempting to read it." 
	17:58:37.883 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:37.883 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_OpenInGameMailRMC:14 
sending msg: 0x7:12 OpenInGameMailRMC { mail: 6869923 } 
	17:58:37.938 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:38.028 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:38.028 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:38.028 DEBUG 8556 from_server::pregame::PreGameMessage_OpenInGameMailRMR:9 
received msg: 0x7:3a OpenInGameMailRMR { error: 0 } 
	17:58:38.028 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:48] [pg_mail_controller.lub:522] Read mail with errorcode: 0" 
	17:58:38.028 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:48] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:38.028 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:48] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:38.037 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllLimitedPoolsForCharacterRMR:9 
received msg: 0x7:37 GetAllLimitedPoolsForCharacterRMR 
	17:58:38.049 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:38.049 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMC:14 
sending msg: 0x7:26 GetAllCardsForCharacterCompressedRMC 
	17:58:38.099 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:38.145 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:38.146 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:38.146 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMR:9 
received msg: 0x7:4e GetAllCardsForCharacterCompressedRMR { cards: CardsCompressed { cards_size: 56 } } 
	17:58:38.148 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:38.148 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMC:14 
sending msg: 0x7:24 GetAllCardUpgradesForCharacterCompressedRMC 
	17:58:38.199 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:38.288 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:38.288 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:38.288 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMR:9 
received msg: 0x7:4c GetAllCardUpgradesForCharacterCompressedRMR { upgrades: Upgrades { upgrades_size: 2 } } 
	17:58:38.291 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:38.291 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllBoostersForCharacterRMC:14 
sending msg: 0x7:21 GetAllBoostersForCharacterRMC 
	17:58:38.341 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:38.430 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:38.430 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:38.430 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllBoostersForCharacterRMR:9 
received msg: 0x7:49 GetAllBoostersForCharacterRMR { boosters: [] } 
	17:58:38.434 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:38.434 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetAllDecksForCharacterRMC:14 
sending msg: 0x7:1c GetAllDecksForCharacterRMC 
	17:58:38.503 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:38.591 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:38.591 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:38.591 DEBUG 8556 from_server::pregame::PreGameMessage_GetAllDecksForCharacterRMR:9 
received msg: 0x7:43 GetAllDecksForCharacterRMR { decks: Decks { decks_size: 2 } } 
	17:58:38.593 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:224] Inventory updated." 
	17:58:38.593 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:163] Updating mode selection." 
	17:58:38.593 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 
	17:58:38.594 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:185] Cardpool found with id:1" 
	17:58:38.594 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:185] Cardpool found with id:2" 
	17:58:38.594 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:288] Updating deck bar with deck FrostNature" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:215] Updating deck name" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:298] Resetting all card slots" 
	17:58:38.595 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:223] Updating card slots" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:202] Updating cover card" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [deck_utils.lub:12] RetrieveAllData: 1" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_inventory_controller.lub:212] Current deck changed." 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:279] Deck changed to FrostNature" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:288] Updating deck bar with deck FrostNature" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:215] Updating deck name" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:298] Resetting all card slots" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:223] Updating card slots" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:202] Updating cover card" 
	17:58:38.596 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_deck_bar_controller.lub:183] Updating new deck button" 
	17:58:38.597 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_mail_controller.lub:530] Reloaded card data caused by mail deletion." 
	17:58:38.597 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_mail_controller.lub:222] Attempting to disable new mail FX" 
	17:58:38.597 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_mail_controller.lub:217] Unread mail count is 0" 
	17:58:38.597 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:49] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 
	17:58:39.627 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:550] Deleting mail from inside mail." 
	17:58:39.627 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:567] Mail had items: 0. Succesfully collected them" 
	17:58:39.632 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:39.632 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_DeleteInGameMailRMC:14 
sending msg: 0x7:11 DeleteInGameMailRMC { mail: 6869923 } 
	17:58:39.688 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:39.777 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:39.777 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:39.777 DEBUG 8556 from_server::pregame::PreGameMessage_DeleteInGameMailRMR:9 
received msg: 0x7:39 DeleteInGameMailRMR { error: 0 } 
	17:58:39.777 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:39.777 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:39.777 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:570] Deleted mail from inside mail with errorCode:0" 
	17:58:39.779 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:338] Attempting to switch to screen 1" 
	17:58:39.779 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:39.779 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:350] Switched to mail inbox tab." 
	17:58:39.779 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:237] Updating mail inbox." 
	17:58:39.787 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:39.787 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 
sending msg: 0x7:14 GetInGameMailRMC 
	17:58:39.842 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:39.930 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:39.930 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:39.930 DEBUG 8556 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 
received msg: 0x7:3c GetInGameMailRMR { mails: [Mail { id: 6866033, sender: None, header: "", body: "{\"ID\":1,\"Tag\": \"QuestComplete\",\"Data\": [6]}", cards: [], mail_type: 1, boosters: [], creation_date: 1599425590, gold: 0, type_: 2, bfp: 75, collected: true, auction_card: "No card", auction_bfp: 0 }, Mail { id: 6866034, sender: None, header: "", body: "{\"ID\":1,\"Tag\": \"QuestComplete\",\"Data\": [1]}", cards: [], mail_type: 1, boosters: [], creation_date: 1599425590, gold: 0, type_: 2, bfp: 0, collected: true, auction_card: "No card", auction_bfp: 0 }] } 
	17:58:39.930 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:240] Fetched mails from server." 
	17:58:39.930 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2" 
	17:58:39.932 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:50] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2" 
	17:58:41.206 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:51] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:41.362 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:51] [pg_mail_controller.lub:395] Reading a mail..." 
	17:58:41.362 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:51] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:41.373 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:41.373 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_OpenInGameMailRMC:14 
sending msg: 0x7:12 OpenInGameMailRMC { mail: 6866034 } 
	17:58:41.425 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:41.516 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:41.516 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:41.516 DEBUG 8556 from_server::pregame::PreGameMessage_OpenInGameMailRMR:9 
received msg: 0x7:3a OpenInGameMailRMR { error: 0 } 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_mail_controller.lub:463] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2 Cards:0 Boosters:0 BFP:0" 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_mail_controller.lub:222] Attempting to disable new mail FX" 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_mail_controller.lub:217] Unread mail count is 0" 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_mail_controller.lub:338] Attempting to switch to screen 3" 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:41.518 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:52] [pg_mail_controller.lub:386] Switched to read mail tab." 
	17:58:42.121 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:42.210 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:42.210 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:42.210 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 
received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 30648, gold: 2309, name: "WitheredOros", rank: 0, avatar: Card { card: "Lost Dragon" }, state: 0, location: 0, map: Introduction, experience: 20868, elo: 0, highest_elo: 0 } } 
	17:58:43.065 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:550] Deleting mail from inside mail." 
	17:58:43.065 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:567] Mail had items: 0. Succesfully collected them" 
	17:58:43.068 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:43.069 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_DeleteInGameMailRMC:14 
sending msg: 0x7:11 DeleteInGameMailRMC { mail: 6866034 } 
	17:58:43.122 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:43.210 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:43.210 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:43.210 DEBUG 8556 from_server::pregame::PreGameMessage_DeleteInGameMailRMR:9 
received msg: 0x7:39 DeleteInGameMailRMR { error: 0 } 
	17:58:43.211 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:43.211 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:43.211 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:570] Deleted mail from inside mail with errorCode:0" 
	17:58:43.213 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:338] Attempting to switch to screen 1" 
	17:58:43.213 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:43.213 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:350] Switched to mail inbox tab." 
	17:58:43.213 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:237] Updating mail inbox." 
	17:58:43.222 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:43.222 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 
sending msg: 0x7:14 GetInGameMailRMC 
	17:58:43.280 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:43.369 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:43.369 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:43.369 DEBUG 8556 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 
received msg: 0x7:3c GetInGameMailRMR { mails: [Mail { id: 6866033, sender: None, header: "", body: "{\"ID\":1,\"Tag\": \"QuestComplete\",\"Data\": [6]}", cards: [], mail_type: 1, boosters: [], creation_date: 1599425590, gold: 0, type_: 2, bfp: 75, collected: true, auction_card: "No card", auction_bfp: 0 }] } 
	17:58:43.369 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:240] Fetched mails from server." 
	17:58:43.369 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:53] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2" 
	17:58:43.970 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:862] Updating read button state." 
	17:58:44.126 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:395] Reading a mail..." 
	17:58:44.126 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:44.135 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:44.135 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_OpenInGameMailRMC:14 
sending msg: 0x7:12 OpenInGameMailRMC { mail: 6866033 } 
	17:58:44.190 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:44.276 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:44.276 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:44.276 DEBUG 8556 from_server::pregame::PreGameMessage_OpenInGameMailRMR:9 
received msg: 0x7:3a OpenInGameMailRMR { error: 0 } 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:463] Updated single mail. IsEAMail:1 From: Subject: Date:09/07/2020 Type:1 State:2 Cards:0 Boosters:0 BFP:0" 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:222] Attempting to disable new mail FX" 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:217] Unread mail count is 0" 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:338] Attempting to switch to screen 3" 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:44.276 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:54] [pg_mail_controller.lub:386] Switched to read mail tab." 
	17:58:46.113 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:550] Deleting mail from inside mail." 
	17:58:46.113 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:567] Mail had items: 0. Succesfully collected them" 
	17:58:46.116 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:46.116 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_DeleteInGameMailRMC:14 
sending msg: 0x7:11 DeleteInGameMailRMC { mail: 6866033 } 
	17:58:46.174 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:46.262 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:46.262 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:46.262 DEBUG 8556 from_server::pregame::PreGameMessage_DeleteInGameMailRMR:9 
received msg: 0x7:39 DeleteInGameMailRMR { error: 0 } 
	17:58:46.264 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:46.264 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_inventory_controller.lub:237] Currency updated." 
	17:58:46.264 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:570] Deleted mail from inside mail with errorCode:0" 
	17:58:46.266 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:338] Attempting to switch to screen 1" 
	17:58:46.266 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:46.266 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:350] Switched to mail inbox tab." 
	17:58:46.266 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:237] Updating mail inbox." 
	17:58:46.269 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:46.269 DEBUG 8556 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 
sending msg: 0x7:14 GetInGameMailRMC 
	17:58:46.320 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:46.409 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:46.409 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:46.409 DEBUG 8556 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 
received msg: 0x7:3c GetInGameMailRMR { mails: [] } 
	17:58:46.410 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:56] [pg_mail_controller.lub:240] Fetched mails from server." 
	17:58:48.704 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:224] Inventory updated." 
	17:58:48.704 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:163] Updating mode selection." 
	17:58:48.704 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 
	17:58:48.705 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:185] Cardpool found with id:1" 
	17:58:48.705 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:185] Cardpool found with id:2" 
	17:58:48.705 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:48.705 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:288] Updating deck bar with deck FrostNature" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:215] Updating deck name" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:298] Resetting all card slots" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:223] Updating card slots" 
	17:58:48.706 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:202] Updating cover card" 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_mail_controller.lub:162] Updating mail attachments." 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Mail\'" 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_mail_controller.lub:878] Storing current mail text input fields." 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:224] Inventory updated." 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:163] Updating mode selection." 
	17:58:48.707 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 
	17:58:48.708 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:185] Cardpool found with id:1" 
	17:58:48.708 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:185] Cardpool found with id:2" 
	17:58:48.708 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:48.708 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:288] Updating deck bar with deck FrostNature" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:215] Updating deck name" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:298] Resetting all card slots" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:223] Updating card slots" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_deck_bar_controller.lub:202] Updating cover card" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_mail_controller.lub:162] Updating mail attachments." 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_navigation_controller.lub:189] Checking for new mail ... checkServer=0" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 
	17:58:48.709 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:293] Activate Deckbuiler" 
	17:58:48.710 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 
	17:58:48.710 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:124] Deckbuilder is ParentView" 
	17:58:48.710 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:136] HidePregameSections" 
	17:58:48.710 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 
	17:58:48.710 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_tutorial_helper.lub:10] ShowTutorial 1" 
	17:58:48.710 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:00:59] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:58:51.862 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to GameWizard" 
	17:58:51.862 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 
	17:58:51.862 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:302] DeActivate Deckbuiler" 
	17:58:51.863 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 
	17:58:51.863 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:124] Deckbuilder is ParentView" 
	17:58:51.863 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:132] ShowPregameSections" 
	17:58:51.863 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 
	17:58:51.863 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'GameWizard\'" 
	17:58:51.863 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_game_section.lub:47] Initialize GameSection!" 
	17:58:51.864 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_screen_flow.lub:52] ScreenFlow:Next(bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml)" 
	17:58:51.864 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_screen_flow.lub:10] DoTransition: bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml" 
	17:58:51.864 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_screen_flow.lub:34] OnNextView! #0" 
	17:58:51.864 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml" 
	17:58:52.110 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_tutorial_helper.lub:10] ShowTutorial 16" 
	17:58:52.110 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 
	17:58:52.110 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_tutorial_helper.lub:46] ...adding position" 
	17:58:52.111 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 
	17:58:52.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:30] PregameSection.Open" 
	17:58:52.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:58:52.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:58:52.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_worldmap_controller_new.lub:11] WorldmapController...Initialize" 
	17:58:52.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_worldmap_controller_new.lub:13] ...done" 
	17:58:52.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_worldmap_controller_new.lub:112] WorldmapController:AddDelegates()" 
	17:58:52.114 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_worldmap_controller_new.lub:160] WorldmapController...Update..." 
	17:58:52.122 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:52.122 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: true, map: NotAMap } 
	17:58:52.175 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:52.264 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:52.264 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:52.264 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [GameOverview { id: 1016, map: 15, leader: CNetWorldPlayerCompressedVO { guid: 55746, gold: 34240, name: "GauntKetz", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -1 } }, state: 1, location: 2, map: Haladur, experience: 172638, elo: 38002, highest_elo: 96323 }, open_slots: 1, difficulty: 13, reward_mode: 1, map_file_cc: 0, combined_crc: 0, map_names: [], map_of_the_month: 0, available_on_server: false }] } 
	17:58:52.276 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:52.276 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: NotAMap } 
	17:58:52.332 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:52.422 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:52.422 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:52.422 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [GameOverview { id: 1003, map: 108, leader: CNetWorldPlayerCompressedVO { guid: 785, gold: 12598, name: "Survivol", rank: 0, avatar: Card { card: "Avatar of Frost" }, state: 1, location: 4, map: CommunityMap4P, experience: 294533, elo: 0, highest_elo: 0 }, open_slots: 3, difficulty: 1, reward_mode: 1, map_file_cc: 4235561634, combined_crc: 8479232716124293794, map_names: ["Die Festung Der Zwerge", "The Dwarfen Stronghold", "", ""], map_of_the_month: 0, available_on_server: false }] } 
	17:58:52.425 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_4P doesn\'t exist!" 
	17:58:52.458 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:50] Show ActiveView" 
	17:58:52.458 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:30] PregameSection.Open" 
	17:58:52.458 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:58:52.458 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:58:52.458 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_worldmap_controller_new.lub:11] WorldmapController...Initialize" 
	17:58:52.458 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:02] [pg_worldmap_controller_new.lub:160] WorldmapController...Update..." 
	17:58:52.463 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:52.463 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: true, map: NotAMap } 
	17:58:52.512 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:52.602 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:52.602 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:52.602 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [GameOverview { id: 1016, map: 15, leader: CNetWorldPlayerCompressedVO { guid: 55746, gold: 34240, name: "GauntKetz", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -1 } }, state: 1, location: 2, map: Haladur, experience: 172638, elo: 38002, highest_elo: 96323 }, open_slots: 1, difficulty: 13, reward_mode: 1, map_file_cc: 0, combined_crc: 0, map_names: [], map_of_the_month: 0, available_on_server: false }] } 
	17:58:52.607 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:52.607 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: NotAMap } 
	17:58:52.662 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:52.751 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:52.751 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:52.751 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [GameOverview { id: 1003, map: 108, leader: CNetWorldPlayerCompressedVO { guid: 785, gold: 12598, name: "Survivol", rank: 0, avatar: Card { card: "Avatar of Frost" }, state: 1, location: 4, map: CommunityMap4P, experience: 294533, elo: 0, highest_elo: 0 }, open_slots: 3, difficulty: 1, reward_mode: 1, map_file_cc: 4235561634, combined_crc: 8479232716124293794, map_names: ["Die Festung Der Zwerge", "The Dwarfen Stronghold", "", ""], map_of_the_month: 0, available_on_server: false }] } 
	17:58:52.751 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_4P doesn\'t exist!" 
	17:58:52.758 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:03] [pg_section.lub:50] Show ActiveView" 
	17:58:55.108 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:55.200 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:55.200 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:55.200 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 41549, player_name: "PrincessKenny", message: "Promo harvester = 17k firedancer=15k juggernaut=deffinately not 2k" } 
	17:58:56.417 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:06] [pg_worldmap_controller_new.lub:245] WorldmapController...Refresh..." 
	17:58:56.417 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:06] [pg_worldmap_controller_new.lub:160] WorldmapController...Update..." 
	17:58:56.423 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:56.424 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: true, map: NotAMap } 
	17:58:56.473 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:56.566 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:56.566 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:56.566 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [GameOverview { id: 1016, map: 15, leader: CNetWorldPlayerCompressedVO { guid: 55746, gold: 34240, name: "GauntKetz", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -1 } }, state: 1, location: 2, map: Haladur, experience: 172638, elo: 38002, highest_elo: 96323 }, open_slots: 1, difficulty: 13, reward_mode: 1, map_file_cc: 0, combined_crc: 0, map_names: [], map_of_the_month: 0, available_on_server: false }] } 
	17:58:56.577 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:56.578 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: NotAMap } 
	17:58:56.631 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:56.721 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:56.721 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:56.721 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [GameOverview { id: 1003, map: 108, leader: CNetWorldPlayerCompressedVO { guid: 785, gold: 12598, name: "Survivol", rank: 0, avatar: Card { card: "Avatar of Frost" }, state: 1, location: 4, map: CommunityMap4P, experience: 294533, elo: 0, highest_elo: 0 }, open_slots: 3, difficulty: 1, reward_mode: 1, map_file_cc: 4235561634, combined_crc: 8479232716124293794, map_names: ["Die Festung Der Zwerge", "The Dwarfen Stronghold", "", ""], map_of_the_month: 0, available_on_server: false }] } 
	17:58:56.724 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="The mapfile UGM_DummyMap_4P doesn\'t exist!" 
	17:58:56.753 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_worldmap_controller_new.lub:436] WorldmapController:OnSelectMap(11100)" 
	17:58:56.754 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:56.754 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_LeaveChatChannelRMC:7 
sending msg: 0x6:14 LeaveChatChannelRMC { channel: 1073 } 
	17:58:56.802 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:56.893 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:56.893 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:56.893 DEBUG 8556 from_server::chat::ChatMessage_LeaveChatChannelRMR:8 
received msg: 0x6:1a LeaveChatChannelRMR 
	17:58:56.907 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:56.907 DEBUG 8556 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 
sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 1, map: SiegeOfHope } 
	17:58:56.958 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:57.047 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:57.047 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:57.047 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:57.047 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionRMR:8 
received msg: 0x6:1b JoinChatRegionRMR { channel: 129, players: [JoinChatRegionPlayer { player: 57265, rank: 0, name: "KyroneRustmore" }, JoinChatRegionPlayer { player: 57158, rank: 0, name: "Smirz" }, JoinChatRegionPlayer { player: 57263, rank: 0, name: "Firearc" }, JoinChatRegionPlayer { player: 57249, rank: 0, name: "Kimahri1980" }] } 
	17:58:57.047 DEBUG 8556 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 
received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 129, player: CNetWorldPlayerCompressedVO { guid: 57249, gold: 105, name: "Kimahri1980", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -23 } }, state: 1, location: 2, map: SiegeOfHope, experience: 674, elo: 0, highest_elo: 0 } } 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_player_location_search_controller.lub:152] OnChatRegionChanged...PlayerLocationSearchController..." 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:54] ScreenFlow:Next()" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:71] current screen:bf1/ui/dialogs/pregame/worldmap/pg_worldmap_view_new.xml" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:75] checking screenNext:bf1/ui/dialogs/pregame/game_selection/pg_ranked_games_view.xml" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:75] checking screenNext:bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pve_user_generated_view.xml" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:75] checking screenNext:bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pvp_view.xml" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:75] checking screenNext:bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pve_view.xml" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:77] condition hit!" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:52] ScreenFlow:Next(bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pve_view.xml)" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_worldmap_controller_new.lub:423] WorldmapController...Close..." 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_worldmap_controller_new.lub:425] ...RemoveDelegates" 
	17:58:57.060 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_worldmap_controller_new.lub:136] WorldmapController:RemoveDelegates()" 
	17:58:57.061 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:10] DoTransition: bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pve_view.xml" 
	17:58:57.061 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_screen_flow.lub:34] OnNextView! #1" 
	17:58:57.061 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pve_view.xml" 
	17:58:57.187 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_tutorial_helper.lub:10] ShowTutorial 44" 
	17:58:57.187 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:58:57.187 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_section.lub:30] PregameSection.Open" 
	17:58:57.187 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:58:57.187 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:58:57.187 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:9] PvEGameSelectionController...Initialize" 
	17:58:57.188 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:11] ...done." 
	17:58:57.188 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:116] PvEGameSelectionController...InitializeLootDropdown..." 
	17:58:57.188 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:227] OnLootTypeSelected...PvEGameSelectionController..." 
	17:58:57.188 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:227] OnLootTypeSelected...PvEGameSelectionController..." 
	17:58:57.188 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:23] PvEGameSelectionController:OnDifficultySelected" 
	17:58:57.189 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:30] GameSelectionControllerBase...Initialize..." 
	17:58:57.189 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:335] GameSelectionControllerBase...CheckNextBtnState..." 
	17:58:57.189 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:337] ...leader, hiding next button." 
	17:58:57.189 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:159] PvEGameSelectionController...UpdateDifficultyButtons..." 
	17:58:57.189 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:167] ...easy." 
	17:58:57.189 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:297] PvEGameSelectionController:UpdateMapOfTheWeekButton" 
	17:58:57.193 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:57.193 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMC:7 
sending msg: 0x8:3f GetAllOpenCustomGamesRMC { pvp: false, map: SiegeOfHope } 
	17:58:57.247 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:57.338 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:57.338 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:57.338 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_GetAllOpenCustomGamesRMR:16 
received msg: 0x8:55 GetAllOpenCustomGamesRMR { games: [] } 
	17:58:57.338 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:404] GameSelectionControllerBase... CheckForCorrectJoinBtnState..." 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:263] UpdateDeckMode...GameSelectionControllerBase.. - early out, no sufficient widgets!" 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:335] GameSelectionControllerBase...CheckNextBtnState..." 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:337] ...leader, hiding next button." 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:370] GameSelectionControllerBase...CheckCreateBtnState..." 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:380] ...no match maker concrete, enable." 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:404] GameSelectionControllerBase... CheckForCorrectJoinBtnState..." 
	17:58:57.339 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_pve_controller.lub:97] PvEGameSelectionController...AddDelegates..." 
	17:58:57.340 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_game_selection_base_controller.lub:58] GameSelectionControllerBase:AddDelegates()" 
	17:58:57.343 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_section.lub:50] Show ActiveView" 
	17:58:57.360 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:07] [pg_tutorial_helper.lub:96] Tutorial Aborted: 16" 
	17:58:59.829 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_game_selection_base_controller.lub:292] GameSelectionControllerBase...Close..." 
	17:58:59.830 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_game_selection_base_controller.lub:299] GameSelectionControllerBase:RemoveDelegates()" 
	17:58:59.834 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:58:59.834 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_CreateCustomGameRMC:7 
sending msg: 0x8:43 CreateCustomGameRMC { deck: 466299, map: SiegeOfHope, difficulty: 1, reward_mode: 1, pvp: false, map_file_checksum: 0, combined_checksum: 0, map_names: [], map_of_the_month: false } 
	17:58:59.899 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:58:59.990 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:59.990 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:59.990 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:58:59.990 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:58:59.990 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_CreateCustomGameRMR:16 
received msg: 0x8:59 CreateCustomGameRMR { error: 0, player: 57249, match_id: 1018, pvp: false } 
	17:58:59.990 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_CustomGameCreatedNotification:16 
received msg: 0x8:2a CustomGameCreatedNotification { player: 57249, map: SiegeOfHope, difficulty: 1, match_id: 1018, pvp: false, is_open: true, map_file_cc: 0, combined_crc: 0 } 
	17:58:59.990 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_CustomGameUpdatedNotification:16 
received msg: 0x8:2c CustomGameUpdatedNotification { match_id: 1018, map: SiegeOfHope, pvp: false, team1: [Some(MatchPlayer { id: 57249, name: "Kimahri1980", deck_name: "FrostNature", cover_card: 288, ready: false, pve_level: 2, elo: 0, deck_level: 0 })], team2: [] } 
	17:58:59.991 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 
	17:58:59.991 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 
	17:58:59.991 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:71] show teamlist" 
	17:58:59.993 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:140] ownteam 4" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_eventwindow_controller.lub:87] OnMatchCreated...EventWindowController" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:54] ScreenFlow:Next()" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:71] current screen:bf1/ui/dialogs/pregame/game_selection/pg_game_selection_pve_view.xml" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:75] checking screenNext:bf1/ui/dialogs/pregame/matchmaking/pg_matchmaking_view.xml" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:77] condition hit!" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:52] ScreenFlow:Next(bf1/ui/dialogs/pregame/matchmaking/pg_matchmaking_view.xml)" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_game_selection_base_controller.lub:292] GameSelectionControllerBase...Close..." 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_game_selection_base_controller.lub:299] GameSelectionControllerBase:RemoveDelegates()" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:10] DoTransition: bf1/ui/dialogs/pregame/matchmaking/pg_matchmaking_view.xml" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_screen_flow.lub:34] OnNextView! #2" 
	17:58:59.998 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/matchmaking/pg_matchmaking_view.xml" 
	17:59:00.109 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_tutorial_helper.lub:10] ShowTutorial 45" 
	17:59:00.109 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 
	17:59:00.109 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_tutorial_helper.lub:10] ShowTutorial 47" 
	17:59:00.109 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 
	17:59:00.109 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_tutorial_helper.lub:46] ...adding position" 
	17:59:00.110 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 
	17:59:00.111 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_section.lub:30] PregameSection.Open" 
	17:59:00.111 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 
	17:59:00.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_section.lub:41] PregameSection.Open: Initialize controller" 
	17:59:00.112 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:26] MatchmakingController...Initialize" 
	17:59:00.120 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:59:00.120 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:00.120 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 4, state: 1, map: SiegeOfHope } 
	17:59:00.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:29] ...done" 
	17:59:00.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:253] MatchmakingController...UpdateMinimapData..." 
	17:59:00.135 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:566] MatchmakingController...CreateTeamSlotList..." 
	17:59:00.135 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:574] TeamFound: 4" 
	17:59:00.135 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:578] SlotCount: 1" 
	17:59:00.216 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:586] Adding teamslot to team1: 1" 
	17:59:00.216 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:574] TeamFound: 7" 
	17:59:00.217 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:163] MatchmakingController:AddDelegates()1" 
	17:59:00.220 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:150] MatchmakingController...DoInitialChecks..." 
	17:59:00.220 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_eventwindow_controller.lub:113] OnMatchMakingSection...1" 
	17:59:00.230 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_SetSpeedRunRMR:16 
received msg: 0x8:4c SetSpeedRunRMR 
	17:59:00.232 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_section.lub:50] Show ActiveView" 
	17:59:00.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 
	17:59:00.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 
	17:59:00.235 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:71] show teamlist" 
	17:59:00.236 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 
	17:59:00.241 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_playerlist_controller.lub:140] ownteam 4" 
	17:59:00.241 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:852] OnMatchUpdated...MatchmakingController..." 
	17:59:00.241 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:253] MatchmakingController...UpdateMinimapData..." 
	17:59:00.241 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:10] [pg_matchmaking_controller.lub:150] MatchmakingController...DoInitialChecks..." 
	17:59:01.692 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:01.692 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_PlayerReadyStatusChangedRMC:7 
sending msg: 0x8:47 PlayerReadyStatusChangedRMC { deck: 466299, match_id: 1018, ready: true } 
	17:59:01.751 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:59:01.841 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:01.841 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:01.841 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:59:01.841 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_PlayerReadyStatusChangedRMR:16 
received msg: 0x8:5d PlayerReadyStatusChangedRMR { error: 0 } 
	17:59:01.841 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_CustomGameUpdatedNotification:16 
received msg: 0x8:2c CustomGameUpdatedNotification { match_id: 1018, map: SiegeOfHope, pvp: false, team1: [Some(MatchPlayer { id: 57249, name: "Kimahri1980", deck_name: "FrostNature", cover_card: 288, ready: true, pve_level: 2, elo: 0, deck_level: 0 })], team2: [] } 
	17:59:01.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:146] Player toggled ready status. New status 1" 
	17:59:01.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:257] Attempt at toggling deckbar status. New status 0" 
	17:59:01.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:260] Toggled deckbar active status. New status 0" 
	17:59:01.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:59:01.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 
	17:59:01.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:156] Updating decks button. New status 0" 
	17:59:01.845 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:183] Updating new deck button" 
	17:59:01.845 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_deck_bar_controller.lub:169] Updating lock deck button" 
	17:59:01.845 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_matchmaking_controller.lub:869] OnPlayerReadyStateChanged...MatchmakingController..." 
	17:59:01.849 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 
	17:59:01.849 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 
	17:59:01.849 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_playerlist_controller.lub:71] show teamlist" 
	17:59:01.849 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 
	17:59:01.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_playerlist_controller.lub:140] ownteam 4" 
	17:59:01.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_matchmaking_controller.lub:852] OnMatchUpdated...MatchmakingController..." 
	17:59:01.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_matchmaking_controller.lub:253] MatchmakingController...UpdateMinimapData..." 
	17:59:01.855 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:12] [pg_matchmaking_controller.lub:150] MatchmakingController...DoInitialChecks..." 
	17:59:02.814 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_matchmaking_controller.lub:923] Starting Match..." 
	17:59:02.826 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:02.826 DEBUG 8556 sr_packet::from_game::matchmaking::MatchmakingMessage_StartCustomGameRMC:7 
sending msg: 0x8:3d StartCustomGameRMC { match_id: 1018 } 
	17:59:02.891 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:59:02.982 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:02.982 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:02.982 INFO 8556 proxy::networking::connect:656 
Connecting to match server ... 
	17:59:02.982 TRACE 8556 proxy::networking::connect:454 
connecting to: 37.187.137.207:7404 (V4(37.187.137.207:7404)) 
	17:59:02.982 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_StartCustomGameRMR:16 
received msg: 0x8:53 StartCustomGameRMR { error: 0 } 
	17:59:03.085 INFO 8556 proxy::networking::connect:508 
connected TlsStream { io: TcpStream, session: ClientSession { imp: ClientSessionImpl }, state: Stream } 
	17:59:03.085 INFO 8556 proxy::networking::connect:677 
... successfully connected ot match server! 
	17:59:03.085 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:59:03.085 DEBUG 8556 from_server::matchmaking::MatchmakingMessage_CharacterForMatchCompleteNotification:16 
received msg: 0x8:c CharacterForMatchCompleteNotification { match_id: 1018, map: SiegeOfHope, game_server_ip: 0, game_server_port: 0, team: Team1, seed: 0, team_id: 0, team_elo_rating: 0, players: [Player { id: 57249, name: "Kimahri1980", team: Team1, color: 1, deck: Deck { id: 466299, name: "FrostNature", pool: 1, cards: [DeckCard { id: 14362073, position: 0, card: Card { id: 14362073, card: "Master Archers", upgrades: 0, charges: 0 } }, DeckCard { id: 14362074, position: 1, card: Card { id: 14362074, card: "Imperials", upgrades: 0, charges: 0 } }, DeckCard { id: 14362090, position: 2, card: Card { id: 14362090, card: "Warden's Sigil", upgrades: 0, charges: 0 } }, DeckCard { id: 14362091, position: 3, card: Card { id: 14362091, card: "Northern Keep", upgrades: 0, charges: 0 } }, DeckCard { id: 14362087, position: 4, card: Card { id: 14362087, card: "Frost Bite", upgrades: 0, charges: 0 } }, DeckCard { id: 14362089, position: 5, card: Card { id: 14362089, card: "Stone Shards", upgrades: 0, charges: 0 } }, DeckCard { id: 14362088, position: 6, card: Card { id: 14362088, card: "Spirit Hunters", upgrades: 0, charges: 0 } }, DeckCard { id: 14362082, position: 7, card: Card { id: 14362082, card: "Breeding Grounds", upgrades: 0, charges: 0 } }, DeckCard { id: 14362078, position: 8, card: Card { id: 14362078, card: "Cannon Tower", upgrades: 0, charges: 0 } }, DeckCard { id: 14362081, position: 9, card: Card { id: 14362081, card: "Kobold Trick", upgrades: 0, charges: 0 } }, DeckCard { id: 14362084, position: 10, card: Card { id: 14362084, card: "Curse of Oink", upgrades: 0, charges: 0 } }, DeckCard { id: 14362077, position: 11, card: Card { id: 14362077, card: "Ray of Light", upgrades: 0, charges: 0 } }, DeckCard { id: 14362075, position: 12, card: Card { id: 14362075, card: "Silverwind Lancers", upgrades: 0, charges: 0 } }, DeckCard { id: 14362079, position: 13, card: Card { id: 14362079, card: "Swamp Drake", upgrades: 0, charges: 0 } }, DeckCard { id: 14362085, position: 14, card: Card { id: 14362085, card: "Hammerfall", upgrades: 0, charges: 0 } }, DeckCard { id: 14362086, position: 15, card: Card { id: 14362086, card: "Equilibrium", upgrades: 0, charges: 0 } }, DeckCard { id: 14362092, position: 16, card: Card { id: 14362092, card: "Stone Shell", upgrades: 0, charges: 0 } }, DeckCard { id: 14362076, position: 17, card: Card { id: 14362076, card: "Tempest", upgrades: 0, charges: 0 } }, DeckCard { id: 14362080, position: 18, card: Card { id: 14362080, card: "Giant Wyrm", upgrades: 0, charges: 0 } }, DeckCard { id: 14362083, position: 19, card: Card { id: 14362083, card: "Regrowth", upgrades: 0, charges: 0 } }], cover_card: Card { id: 14362073, card: "Master Archers", upgrades: 0, charges: 0 }, level: 0 }, character: CNetWorldPlayerCompressedVO { guid: 57249, gold: 105, name: "Kimahri1980", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -23 } }, state: 1, location: 4, map: SiegeOfHope, experience: 674, elo: 0, highest_elo: 0 } }] } 
	17:59:03.088 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="OnCharacterForMatchComplete triggered MatchID: 1018" 
	17:59:03.088 INFO 9084 proxy::logging:72 
src="NETWORK" message="ResetSequences triggered old MatchID: 0  new MatchID: 1018" 
	17:59:03.089 DEBUG 8556 from_server::chat::ChatMessage_JoinChatChannelRMR:8 
received msg: 0x6:1c JoinChatChannelRMR 
	17:59:03.112 DEBUG 8556 from_server::chat::ChatMessage_JoinChatChannelRMR:8 
received msg: 0x6:1c JoinChatChannelRMR 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_game_section.lub:72] OnMatchStarted...GameSection..." 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_game_section.lub:85] ... switch to matchmaking on match!" 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_game_section.lub:63] Can\'t adopt GroupleaderMapInfo. I\'m the groupleader!" 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to GameWizard" 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_screen_flow.lub:52] ScreenFlow:Next(bf1/ui/dialogs/pregame/matchmaking/pg_matchmaking_view.xml)" 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_screen_flow.lub:58] Screen is already active, do nothing: bf1/ui/dialogs/pregame/matchmaking/pg_matchmaking_view.xml" 
	17:59:03.122 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_game_section.lub:91] OnStartTimer...GameSection..." 
	17:59:03.124 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [timed_task_manager.lub:15] Created new anonymous task" 
	17:59:03.124 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 
	17:59:03.124 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 
	17:59:03.124 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_playerlist_controller.lub:71] show teamlist" 
	17:59:03.125 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 
	17:59:03.130 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_playerlist_controller.lub:140] ownteam 4" 
	17:59:03.130 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_eventwindow_controller.lub:134] UpdateButton...State: Hide, Enable: 1" 
	17:59:03.130 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_eventwindow_controller.lub:136] ...Hide." 
	17:59:03.132 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:13] [pg_game_section.lub:127] OnUpdateTimer...GameSection..." 
	17:59:03.616 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:14] [pg_game_section.lub:127] OnUpdateTimer...GameSection..." 
	17:59:04.614 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:15] [pg_game_section.lub:127] OnUpdateTimer...GameSection..." 
	17:59:05.619 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:16] [pg_game_section.lub:127] OnUpdateTimer...GameSection..." 
	17:59:06.116 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:16] [timed_task.lub:12] Anonymous timed task was destroyed." 
	17:59:06.613 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:17] [pg_game_section.lub:127] OnUpdateTimer...GameSection..." 
	17:59:07.612 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_game_section.lub:127] OnUpdateTimer...GameSection..." 
	17:59:07.612 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_game_section.lub:130] ...loading match!" 
	17:59:07.612 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'GameWizard\'" 
	17:59:07.622 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:59:07.622 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:07.622 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: SiegeOfHope } 
	17:59:07.623 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_matchmaking_controller.lub:334] OnSectionClose...MatchMakingController..." 
	17:59:07.623 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_eventwindow_controller.lub:113] OnMatchMakingSection...0" 
	17:59:07.623 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:59:07.623 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:18] [pg_deck_bar_controller.lub:589] DeckBar isn\'t active, cant change Edit Mode in inactive state" 
	17:59:07.645 INFO 9084 proxy::logging:72 
src="Pathing" message="Destroy Pathing Engine" 
	17:59:07.648 INFO 9084 proxy::logging:72 
src="NETWORK" message="PG_StartMatch triggered MatchID: 1018" 
	17:59:07.655 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:59:07.655 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:07.655 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 1, state: 1, map: SiegeOfHope } 
	17:59:07.789 INFO 9084 proxy::logging:72 
src="Pathing" message="Init Pathing Engine: Path finding (Feb 21 2013/13:42:45) \'_FINAL, _LIB, \'" 
	17:59:07.790 INFO 9084 proxy::logging:72 
src="Pathing.Manager" message="CPathManagerConstructed" 
	17:59:10.272 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="--- Logging map CRCs ---" 
	17:59:10.272 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uBarrierModuleCRC: aecdf428" 
	17:59:10.272 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uBarrierSetCRC: d5d1b9c0" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uBuildingCRC: 357eafbb" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uFigureCRC: 7a242c3f" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uObjectCRC: 605d24a2" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uPlayerCRC: 0" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uPowerSlotCRC: 8a8e14b2" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uProjectileCRC: 0" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uScriptingCRC: 0" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uSquadCRC: 7561300c" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uTokenSlotCRC: c473a66c" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uTurretCRC: 10ffaddd" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="uWorldCRC: 48315402" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="AssetCRC #1: f0ce549b" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="AssetCRC #2: 41c006b8" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="AssetCRC #3: 63a52c01" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="AssetCRC #4: 31b52f4a" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="AssetCRC #5: b6b33c05" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="Combined CRC: aa3e7b23" 
	17:59:10.273 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="--- End of logging map CRCs ---" 
	17:59:10.796 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 4 different playercolors." 
	17:59:10.799 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 5 Flame Locator mappings" 
	17:59:10.799 INFO 9084 proxy::logging:72 
src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 
	17:59:10.805 INFO 9084 proxy::logging:72 
src="CVisSoundWorldPlugin" message="Loaded 3 Reverb settings, defaults to bf1/sound/ir_presets/default.ifr with dry level 0.030000" 
	17:59:10.833 WARN 9084 proxy::game_config:516 
vismain:optionshadowmap '"0"' is not a bool 
	17:59:10.833 WARN 9084 proxy::game_config:321 
vismain:optionshadowmapfilter '"0"' is not a int 
	17:59:10.833 WARN 9084 proxy::game_config:516 
vismain:optionshadowobjects '"0"' is not a bool 
	17:59:10.833 WARN 9084 proxy::game_config:418 
vismain:optiontexturesizebias '"0"' is not a float 
	17:59:10.833 WARN 9084 proxy::game_config:516 
vismain:optionenableglow '"0"' is not a bool 
	17:59:10.833 WARN 9084 proxy::game_config:516 
vismain:optionenablecloudshadow '"0"' is not a bool 
	17:59:10.833 WARN 9084 proxy::game_config:321 
vismain:optionshaderlod '"0"' is not a int 
	17:59:10.840 INFO 9084 proxy::logging:72 
src="VisMain" message="Starting Build Scene..." 
	17:59:12.994 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:59:13.084 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:13.084 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:59:13.084 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 25696, player_name: "GbFlu", message: "WTS--> MO PROMO ---> 5500 BFP / JUGGERNAUT --> 500 BFP" } 
	17:59:22.298 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 
	17:59:22.298 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 
	17:59:22.298 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_playerlist_controller.lub:71] show teamlist" 
	17:59:22.299 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 
	17:59:22.304 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_playerlist_controller.lub:140] ownteam 4" 
	17:59:22.305 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_deck_bar_controller.lub:644] DeckBarController:OnIngame" 
	17:59:22.305 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 
	17:59:22.305 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_deck_bar_controller.lub:589] DeckBar isn\'t active, cant change Edit Mode in inactive state" 
	17:59:22.305 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_chatwindow_controller.lub:352] ChatWindowController:OnIngame()" 
	17:59:22.305 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_chatwindow_controller.lub:352] ChatWindowController:OnIngame()" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:105] Set ExitBtnState 1" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:119] Set SectionsPushButton state to 0, they won\'t be available ingame" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:115] Set SectionsPushButton state 1" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:124] Change contacts button icon" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:119] Set SectionsPushButton state to 0, they won\'t be available ingame" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:119] Set SectionsPushButton state to 0, they won\'t be available ingame" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:119] Set SectionsPushButton state to 0, they won\'t be available ingame" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:115] Set SectionsPushButton state 1" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:110] We are ingame and need to change PushButtonStates" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_navigation_controller.lub:119] Set SectionsPushButton state to 0, they won\'t be available ingame" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_section_browser.lub:127] GameWidget is ParentView" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_section_browser.lub:136] HidePregameSections" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 
	17:59:22.306 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:01:26] [pg_section_browser.lub:334] Match initialized" 
	17:59:22.318 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:59:22.318 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:22.318 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 5, state: 1, map: SiegeOfHope } 
	17:59:22.329 DEBUG 8556 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 
received msg: 0x4:53 ChangeCharacterLocationStateRMR 
	17:59:22.329 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	17:59:22.329 DEBUG 8556 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 
sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 5, state: 2, map: SiegeOfHope } 
	17:59:22.340 DEBUG 8556 sr_packet::from_game::game::GameMessage_MapCompleteLoadedAction:8 
sending msg: 0x5:e MapCompleteLoadedAction { session: 815, token: 5828377345408332181, map_cluster: 0, map_file_id: 15, crc: 2856221475, random_map_crc: 0 } 
	17:59:22.491 DEBUG 8556 from_server::game::GameMessage_GameStartNotification:8 
received msg: 0x5:4 GameStartNotification { match_id: 1018 } 
	17:59:22.493 INFO 9084 proxy::logging:72 
src="PG (PREGAME)" message="OnGameStart... game ID = 1018" 
	17:59:25.607 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 30, data: [2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 132, 161, 25, 83, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 5, 0, 0, 0, 155, 84, 206, 240, 184, 6, 192, 65, 1, 44, 165, 99, 74, 47, 181, 49, 5, 60, 179, 182] } 
	17:59:30.514 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 10, x: 232.57025, y: 190.29161, barrier_to_mount: 0 } } 
	17:59:30.633 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 83, step: 82, command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 10, x: 232.57025, y: 190.29161, barrier_to_mount: 0 } } 
	17:59:33.440 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ProduceSquad { card: 356, player: 5464, position: 1, tag: 65892, played_count: 10, x: 236.95, y: 194.25, barrier_to_mount: 0 } } 
	17:59:33.577 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 113, step: 111, command: ProduceSquad { card: 356, player: 5464, position: 1, tag: 65892, played_count: 10, x: 236.95, y: 194.25, barrier_to_mount: 0 } } 
	17:59:37.602 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 150, data: [2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 228, 126, 150, 172, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	17:59:39.882 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:59:39.968 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:39.969 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:59:39.969 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 11264, player_name: "En1syo", message: "WTT Promo HARVESTER For firedancer promo and juggernaut promo+ i give some bfp" } 
	17:59:40.871 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 255, x: 231.76274, y: 183.97871, barrier_to_mount: 0 } } 
	17:59:41.010 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 189, step: 186, command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 255, x: 231.76274, y: 183.97871, barrier_to_mount: 0 } } 
	17:59:47.252 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	17:59:47.340 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	17:59:47.340 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	17:59:47.340 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 17571, player_name: "Skalli", message: "WTB Cluster Explosion (Fire) x2 ((580))" } 
	17:59:49.615 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 270, data: [1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 180, 227, 125, 77, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	17:59:53.651 WARN 9084 proxy::logging:73 
src="GUI" message="CGUIMiniMap::AddGoalBlip: Tried to add entity twice! (ID: 29)" 
	17:59:57.476 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ProduceSquad { card: 356, player: 5464, position: 1, tag: 65892, played_count: 255, x: 243.95, y: 191.45, barrier_to_mount: 0 } } 
	17:59:57.688 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 356, step: 352, command: ProduceSquad { card: 356, player: 5464, position: 1, tag: 65892, played_count: 255, x: 243.95, y: 191.45, barrier_to_mount: 0 } } 
	18:00:00.193 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(218.77869, 193.0173)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:00.330 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 384, step: 379, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(218.77869, 193.0173)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:00.937 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:00:01.026 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:00:01.026 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:00:01.026 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 55935, player_name: "Donaar", message: "WTB Necrofury, Kobold Engineer, Fallen Skyelf & Lost Vigil (G)" } 
	18:00:01.613 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 390, data: [3, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 70, 7, 86, 178, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:00:03.775 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(261.15286, 186.19643)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:04.001 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 421, step: 415, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(261.15286, 186.19643)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:08.045 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(273.1258, 172.64816)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:08.183 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 464, step: 457, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(273.1258, 172.64816)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:12.870 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:00:12.957 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:00:12.957 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:00:12.957 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 3, player: 25696, player_name: "GbFlu", message: "WTS--> MO PROMO ---> 5500 BFP / JUGGERNAUT --> 500 BFP" } 
	18:00:13.608 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 510, data: [4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 248, 148, 211, 15, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:00:14.829 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(283.51065, 170.4853)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:15.001 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 533, step: 525, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(283.51065, 170.4853)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:18.040 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(303.13898, 167.70828)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:18.179 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 566, step: 557, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(303.13898, 167.70828)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:23.860 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(327.42038, 175.62549)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:24.083 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 626, step: 616, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(327.42038, 175.62549)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:25.612 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 630, data: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 154, 31, 27, 188, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:00:27.924 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(351.13382, 181.81865)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:28.063 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 667, step: 656, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813], positions: [(351.13382, 181.81865)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:33.192 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 255, x: 336.85712, y: 178.19073, barrier_to_mount: 0 } } 
	18:00:33.327 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 721, step: 709, command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 255, x: 336.85712, y: 178.19073, barrier_to_mount: 0 } } 
	18:00:33.511 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5837], positions: [(349.0891, 177.54866)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:33.652 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 725, step: 712, command: GroupGoto { player: 5464, squads: [5837], positions: [(349.0891, 177.54866)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:00:35.294 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 255, x: 344.05, y: 173.25, barrier_to_mount: 0 } } 
	18:00:35.431 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 744, step: 730, command: ProduceSquad { card: 288, player: 5464, position: 0, tag: 288, played_count: 255, x: 344.05, y: 173.25, barrier_to_mount: 0 } } 
	18:00:35.525 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5856], target: CGdTarget { version: 1, targets: [Target { category: 6, sub_category: 0, uid: 10, x: 370.3407, y: 186.52356 }] }, force_attack: 0 } } 
	18:00:35.701 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 747, step: 732, command: GroupAttack { player: 5464, squads: [5856], target: CGdTarget { version: 1, targets: [Target { category: 6, sub_category: 0, uid: 10, x: 370.3407, y: 186.52356 }] }, force_attack: 0 } } 
	18:00:37.517 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 750, data: [2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 105, 98, 112, 101, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:00:42.148 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ModeChange { player: 5464, target: 5786, mode: 348 } } 
	18:00:42.148 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ModeChange { player: 5464, target: 5813, mode: 348 } } 
	18:00:42.257 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 814, step: 798, command: ModeChange { player: 5464, target: 5786, mode: 348 } } 
	18:00:42.344 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 816, step: 799, command: ModeChange { player: 5464, target: 5813, mode: 348 } } 
	18:00:44.932 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ModeChange { player: 5464, target: 5813, mode: 348 } } 
	18:00:45.028 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 844, step: 826, command: ModeChange { player: 5464, target: 5813, mode: 348 } } 
	18:00:49.519 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 870, data: [4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 242, 94, 30, 120, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:00:54.867 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ModeChange { player: 5464, target: 5786, mode: 349 } } 
	18:00:54.867 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: ModeChange { player: 5464, target: 5813, mode: 349 } } 
	18:00:55.039 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 945, step: 926, command: ModeChange { player: 5464, target: 5786, mode: 349 } } 
	18:00:55.039 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 946, step: 926, command: ModeChange { player: 5464, target: 5813, mode: 349 } } 
	18:00:57.958 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4864, x: 389.7316, y: 160.63469 }] }, force_attack: 0 } } 
	18:00:58.141 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 978, step: 957, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4864, x: 389.7316, y: 160.63469 }] }, force_attack: 0 } } 
	18:01:01.511 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 990, data: [1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 109, 156, 144, 124, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:01:04.128 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 1, sub_category: 0, uid: 6065, x: 376.84558, y: 175.94481 }] }, force_attack: 0 } } 
	18:01:04.264 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1040, step: 1018, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 1, sub_category: 0, uid: 6065, x: 376.84558, y: 175.94481 }] }, force_attack: 0 } } 
	18:01:09.585 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4864, x: 389.7316, y: 160.63469 }] }, force_attack: 0 } } 
	18:01:09.722 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1096, step: 1073, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4864, x: 389.7316, y: 160.63469 }] }, force_attack: 0 } } 
	18:01:11.435 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:01:11.526 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:01:11.526 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:01:11.526 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 31143, player_name: "GurucbrPT", message: "wts" } 
	18:01:13.526 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1110, data: [4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 114, 42, 143, 160, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:01:20.169 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4863, x: 417.60608, y: 179.64989 }] }, force_attack: 0 } } 
	18:01:20.389 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1203, step: 1179, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4863, x: 417.60608, y: 179.64989 }] }, force_attack: 0 } } 
	18:01:24.496 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4863, x: 417.60608, y: 179.64989 }] }, force_attack: 0 } } 
	18:01:24.670 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1247, step: 1222, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4863, x: 417.60608, y: 179.64989 }] }, force_attack: 0 } } 
	18:01:25.518 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1230, data: [1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 227, 12, 172, 51, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:01:25.914 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 1, sub_category: 0, uid: 6295, x: 411.5844, y: 188.7367 }] }, force_attack: 0 } } 
	18:01:26.096 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1262, step: 1236, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 1, sub_category: 0, uid: 6295, x: 411.5844, y: 188.7367 }] }, force_attack: 0 } } 
	18:01:28.139 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:01:28.226 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:01:28.226 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:01:28.226 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 2, player: 39517, player_name: "Ghostrider1101", message: "gg" } 
	18:01:31.373 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4863, x: 417.60608, y: 179.64989 }] }, force_attack: 0 } } 
	18:01:31.601 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1318, step: 1291, command: GroupAttack { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], target: CGdTarget { version: 1, targets: [Target { category: 2, sub_category: 0, uid: 4863, x: 417.60608, y: 179.64989 }] }, force_attack: 0 } } 
	18:01:37.522 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1350, data: [4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 98, 44, 227, 237, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:01:41.671 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:01:41.764 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:01:41.764 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:01:41.764 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 2, player: 4613, player_name: "Bini_Inibitor", message: "A" } 
	18:01:42.478 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], positions: [(400.0807, 199.7752)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:01:42.671 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1430, step: 1402, command: GroupGoto { player: 5464, squads: [5759, 5786, 5805, 5813, 5837, 5856], positions: [(400.0807, 199.7752)], walk_mode: 2, run_or_orientation: 1, orientation: 0.0 } } 
	18:01:46.086 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: TokenSlotBuild { player: 5464, slot: 5040, monument: 2 } } 
	18:01:46.298 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1467, step: 1438, command: TokenSlotBuild { player: 5464, slot: 5040, monument: 2 } } 
	18:01:48.368 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:01:48.456 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:01:48.456 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:01:48.456 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 3, player: 11886, player_name: "MyLyrics", message: "B" } 
	18:01:49.518 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1470, data: [3, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 212, 123, 75, 21, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:01:52.774 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:01:52.864 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:01:52.864 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:01:52.864 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 2, player: 4613, player_name: "Bini_Inibitor", message: "Alright here we go bois, the give away is live." } 
	18:02:01.518 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1590, data: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 207, 160, 204, 14, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:02:05.855 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:02:05.942 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:02:05.942 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:02:05.942 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 2, player: 4613, player_name: "Bini_Inibitor", message: "It is pretty simple " } 
	18:02:13.519 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1710, data: [2, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 4, 168, 125, 91, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:02:17.479 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:02:17.569 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:02:17.569 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:02:17.569 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 2, player: 4613, player_name: "Bini_Inibitor", message: "180BFP to give away, for 100 People" } 
	18:02:22.329 DEBUG 8556 proxy::networking::connect:396 
sf; target="threading::forge_send_messages_to_server"
	18:02:22.329 DEBUG 8556 sr_packet::from_game::extensions::ExtensionCommands_KeepAliveAction:16 
sending msg: 0x1:7 KeepAliveAction 
	18:02:23.718 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: PowerSlotBuild { player: 5464, slot: 5021 } } 
	18:02:23.823 DEBUG 8556 from_server::game::GameMessage_AnnounceCommandNotification:8 
received msg: 0x5:b AnnounceCommandNotification { match_id: 1018, sequence_number: 1844, step: 1814, command: PowerSlotBuild { player: 5464, slot: 5021 } } 
	18:02:25.509 DEBUG 8556 sr_packet::from_game::game::GameMessage_SyncCheckAction:8 
sending msg: 0x5:3 SyncCheckAction { map_cluster: 0, step: 1830, data: [1, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 33, 169, 10, 50, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0] } 
	18:02:25.997 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 4 and self.size = 0 
	18:02:26.086 DEBUG 8556 proxy::networking::connect:434 
rf; target="threading::handle_packet_from_forge_server"
	18:02:26.086 TRACE 8556 sr_packet::sr_packet_coder:43 
Decode returned Ok(None). buf.len() = 0 and self.size = 0 
	18:02:26.086 DEBUG 8556 from_server::chat::ChatMessage_SayNotification:8 
received msg: 0x6:d SayNotification { channel: 129, state: 1, location: 2, player: 4613, player_name: "Bini_Inibitor", message: "So 1800 BFP for each person." } 
	18:03:10.787 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:14] [timed_task_manager.lub:15] Created new anonymous task" 
	18:03:10.843 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:14] [timed_task.lub:12] Anonymous timed task was destroyed." 
	18:03:17.060 DEBUG 8556 sr_packet::from_game::game::GameMessage_RequestCommandAction:8 
sending msg: 0x5:a RequestCommandAction { command: PlayerSurrender { player: 5464 } } 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:514] pg_exit_game" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:403] SectionBrowser:Exit..." 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:410] SectionBrowser.Close" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: UIEditor" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: News" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_widget_controller.lub:61] Calling a deprecated Method: WidgetController:Close" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: OpenedBooster" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: Login" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: CommandBuilder" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: Options" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: CardUpgrade" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: StoryBook" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: DeckCreation" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: PlayersControlView" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: DirectTrade" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: GameWizard" 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_matchmaking_controller.lub:315] MatchmakingController...Close..." 
	18:03:17.071 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_matchmaking_controller.lub:210] MatchmakingController:RemoveDelegates()" 
	18:03:17.072 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_eventwindow_controller.lub:113] OnMatchMakingSection...0" 
	18:03:17.072 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: Marketplace" 
	18:03:17.072 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: DeckControl" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: ShowDeck" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: Mail" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_widget_controller.lub:61] Calling a deprecated Method: WidgetController:Close" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: Replays" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: LatestBooster" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_section_browser.lub:412] Destroying Section: Forge" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_inventory_controller.lub:54] Inventory controller: Close" 
	18:03:17.073 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_inventory_controller.lub:119] Removing inventory controller delegates." 
	18:03:17.075 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_playerlist_controller.lub:56] PlayerListController...Close..." 
	18:03:17.075 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_playerlist_controller.lub:58] ...RemoveDelegates" 
	18:03:17.075 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_playerlist_controller.lub:36] RemoveDelegates...PlayerListController..." 
	18:03:17.081 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_navigation_controller.lub:58] RemoveDelegates...NavigationController" 
	18:03:17.082 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_deck_bar_controller.lub:139] Deck bar closed. Saving current deck and removing delegates" 
	18:03:17.082 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_deck_bar_controller.lub:83] Removing deck bar delegates." 
	18:03:17.085 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_widget_controller.lub:61] Calling a deprecated Method: WidgetController:Close" 
	18:03:17.086 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_public_chatwindow_controller.lub:45] Successfully closed PublicChatWindowController." 
	18:03:17.086 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_player_location_search_controller.lub:118] PlayerLocationSearchController...Close..." 
	18:03:17.086 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_player_location_search_controller.lub:95] PlayerLocationSearchController...RemoveDelegates..." 
	18:03:17.088 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_private_chatwindow_controller.lub:38] Successfully closed PrivateChatWindowController." 
	18:03:17.088 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_eventwindow_controller.lub:161] EventWindowController...Close..." 
	18:03:17.088 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_eventwindow_controller.lub:163] ...RemoveDelegates" 
	18:03:17.088 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_eventwindow_controller.lub:58] EventWindowController:RemoveDelegates()" 
	18:03:17.093 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_notification_listener.lub:156] Removing Notification listener..." 
	18:03:17.094 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_notification_listener.lub:158] Notification listener removed!" 
	18:03:17.094 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_packet_listener.lub:155] Removing Packet listener..." 
	18:03:17.095 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [pg_packet_listener.lub:157] Packet listener removed!" 
	18:03:22.096 INFO 9084 proxy::networking::connect:288 
destroying 
	18:03:22.096 INFO 9084 proxy::networking::open_ssl_wrapper:129 
disconnecting 
	18:03:22.097 INFO 9084 proxy::networking::open_ssl_wrapper:144 
disconnected 
	18:03:22.097 INFO 9084 proxy::networking::connect:290 
destroyed 
	18:03:22.098 INFO 9084 proxy::logging:72 
src="PREGAME" message="CharacterRemote deletion." 
	18:03:22.162 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [timed_task.lub:12] Anonymous timed task was destroyed." 
	18:03:22.162 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [timed_task.lub:10] Timed task \"ReEnableLogin\" was destroyed." 
	18:03:22.162 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [timed_task.lub:10] Timed task \"RefreshPlayerRegionList\" was destroyed." 
	18:03:22.162 INFO 9084 proxy::logging:72 
src="UI (Lua)" message="[00:05:21] [timed_task.lub:12] Anonymous timed task was destroyed." 
	18:03:23.999 INFO 9084 proxy::logging:72 
src="Pathing" message="Destroy Pathing Engine" 
	18:03:25.940 ERROR 9084 proxy::logging:74 
src="BASE" message="Unhandled exception error. Crash dump written." 
	18:03:25.940 ERROR 9084 proxy::logging:74 
src="BASE" message=""