2:45:37.759 WARN 13764 proxy:78 proxy from 2020-09-03T21:20:57.318048700Z is initializing 2:45:37.761 INFO 13764 proxy::networking::connect:181 connect disconnect hooks initialized 2:45:37.761 INFO 13764 proxy::networking:69 networking hooks initialized 2:45:37.761 WARN 13764 proxy:102 Initialized successfully 2:45:38.017 WARN 13764 proxy::game_config:307 application:maxshader 'false' is not a int 2:45:38.025 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Start Scan" 2:45:38.053 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Found Adapter: NVIDIA GeForce GTX 1080" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Support Hardware vertex processing" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Support SM 3.0" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Found Adapter: NVIDIA GeForce GTX 1080" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Support Hardware vertex processing" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 9" message="Support SM 3.0" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 9" message="End Scan" 2:45:38.054 INFO 13764 proxy::logging:72 src="Direct3D 11" message="Start DXGI scan." 2:45:38.058 INFO 13764 proxy::logging:72 src="Direct3D 11" message="Found Adapter: NVIDIA GeForce GTX 1080" 2:45:38.110 INFO 13764 proxy::logging:72 src="Direct3D 11" message="Supports Techlevel 11.0" 2:45:38.110 INFO 13764 proxy::logging:72 src="Direct3D 11" message="Found Adapter: NVIDIA GeForce GTX 1080" 2:45:38.138 INFO 13764 proxy::logging:72 src="Direct3D 11" message="Supports Techlevel 11.0" 2:45:38.138 INFO 13764 proxy::logging:72 src="Direct3D 11" message="End DXGI scan." 2:45:38.141 INFO 13764 proxy::logging:72 src="app" message="BattleForge Final Build: 400006 (Retail branch)" 2:45:38.141 INFO 13764 proxy::logging:72 src="app" message="CPU GenuineIntel family 6, model 14 (Core) detected." 2:45:38.505 INFO 13764 proxy::logging:72 src="app" message="CPU clock speed is ~2808 MHz." 2:45:38.505 INFO 13764 proxy::logging:72 src="app" message="CPU has 6 cores." 2:45:38.505 INFO 13764 proxy::logging:72 src="app" message="CPU rating is 22 points." 2:45:38.505 INFO 13764 proxy::logging:72 src="app" message="GFX rating is 0 points." 2:45:38.505 INFO 13764 proxy::logging:72 src="CreateDisplay" message="Creating Display DirectX 11" 2:45:38.526 INFO 13764 proxy::logging:72 src="Create Device" message="Use Direct3D 11" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Vendor ID = 0x10de" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Device ID = 0x1b80" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Subsystem ID = 0x33661028" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Revision = 0xa1" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Device description = NVIDIA GeForce GTX 1080" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Video Memory = -1073741824" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="System Memory = 0" 2:45:38.529 INFO 13764 proxy::logging:72 src="GPU" message="Shared Memory = 1073676288" 2:45:38.539 WARN 13764 proxy::logging:73 src="Direct3D 11" message="Create shader resource view : S_OK" 2:45:38.870 INFO 13764 proxy::logging:72 src="PssSoundPipeline" message="Loading soundpipeline:\n\n Version: 1\nNumber of Files:9604" 2:45:39.118 INFO 13764 proxy::logging:72 src="PssSoundPipeline" message="Loading soundpipeline bf1/sound/SoundPipeline_en.bin finished, 38471.48 seconds of music material in pipe." 2:45:39.213 INFO 13764 proxy::logging:72 src="CPssPhysicalRenderer" message="Got 5.1 Surround speakers!" 2:45:39.436 INFO 13764 proxy::logging:72 src="VisManager" message="Loaded 4 different playercolors." 2:45:39.437 INFO 13764 proxy::logging:72 src="VisManager" message="Loaded 5 Flame Locator mappings" 2:45:39.437 INFO 13764 proxy::logging:72 src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 2:45:39.874 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [timed_task_manager.lub:15] Created new anonymous task" 2:45:39.901 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [event_listener.lub:20] Register EventListener with id 55" 2:45:40.087 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Login" 2:45:40.087 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Login\'" 2:45:40.087 INFO 13764 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)" 2:45:40.087 INFO 13764 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" 2:45:40.087 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_screen_flow.lub:34] OnNextView! #0" 2:45:40.087 INFO 13764 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" 2:45:40.105 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [timed_task_manager.lub:12] Created new task ReEnableLogin" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:30] PregameSection.Open" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:41] PregameSection.Open: Initialize controller" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:50] Show ActiveView" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:30] PregameSection.Open" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:41] PregameSection.Open: Initialize controller" 2:45:40.107 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:01] [pg_section.lub:50] Show ActiveView" 2:45:45.861 INFO 13764 proxy::networking::connect:235 connecting 2:45:45.861 INFO 13764 proxy::networking::connect:290 forge_connect 2:45:46.189 INFO 13764 proxy::networking::connect:332 connected TlsStream { io: TcpStream, session: ClientSession { imp: ClientSessionImpl }, state: Stream } 2:45:46.190 INFO 13764 proxy::networking::connect:240 fully connected 2:45:46.229 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_notification_listener.lub:150] Adding Notification listener..." 2:45:46.229 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_notification_listener.lub:152] Notification listener added!" 2:45:46.229 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:149] Adding Packet listener..." 2:45:46.229 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:151] Packet listener added!" 2:45:46.247 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:46.247 DEBUG 9952 sr_packet::from_game::borderline::BorderlineMessage_LoginAccountRMC:8 sending msg: 0xa:14 LoginAccountRMC { data: LoginAccountData { email: "****", password: "****" } } 2:45:46.652 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:46.652 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:46.652 DEBUG 9952 from_server::borderline::BorderlineMessage_LoginAccountRMR:64 received msg: 0xa:1e LoginAccountRMR { data: LoginAccountRMR { result: Success, warning_type: WarnNone, account: Some(LoginAccountResult { session: 1744, token: 2262419513882701176, character: Some(CNetWorldPlayerCompressedVO { guid: 57174, gold: 25, name: "Skippydamule", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -8 } }, state: 0, location: 0, map: NotAMap, experience: 1590, elo: 0, highest_elo: 0 }), bfp: 313 }) } } 2:45:46.653 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{18}\u{8}" 2:45:46.653 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:133] Request with id 8 was sent!" 2:45:46.653 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:46.653 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_CustomPacket:16 sending msg: 0x1:1 CustomPacket { lua_data: "\u{18}\u{8}" } 2:45:46.814 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:46.815 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:46.815 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:46.815 DEBUG 9952 from_server::chat::ChatMessage_SystemNotification:8 received msg: 0x6:b SystemNotification { message: "\u{1}\u{8}\u{0}\u{0}{\"NotifyPromoDrop\":1,\"ReceivePromoDropNotifications\":2}" } 2:45:46.815 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:65] Header:8|1|1" 2:45:46.815 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:66] Data:{\"NotifyPromoDrop\":1,\"ReceivePromoDropNotifications\":2}" 2:45:46.815 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:74] Received all request packets for request 8" 2:45:46.815 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:07] [pg_packet_listener.lub:75] Combined data: {\"NotifyPromoDrop\":1,\"ReceivePromoDropNotifications\":2}" 2:45:46.819 DEBUG 9952 from_server::borderline::BorderlineMessage_LoginCharacterRMR:64 received msg: 0xa:19 LoginCharacterRMR 2:45:46.831 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllLimitedPoolsForCharacterRMR:9 received msg: 0x7:37 GetAllLimitedPoolsForCharacterRMR 2:45:46.842 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:46.842 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMC:14 sending msg: 0x7:26 GetAllCardsForCharacterCompressedRMC 2:45:47.027 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:47.028 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:47.028 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:47.028 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMR:9 received msg: 0x7:4e GetAllCardsForCharacterCompressedRMR { cards: CardsCompressed { cards_size: 117 } } 2:45:47.038 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:47.038 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMC:14 sending msg: 0x7:24 GetAllCardUpgradesForCharacterCompressedRMC 2:45:47.200 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:47.200 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:47.200 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMR:9 received msg: 0x7:4c GetAllCardUpgradesForCharacterCompressedRMR { upgrades: Upgrades { upgrades_size: 9 } } 2:45:47.204 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:47.204 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllBoostersForCharacterRMC:14 sending msg: 0x7:21 GetAllBoostersForCharacterRMC 2:45:47.364 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:47.364 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:47.364 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:47.364 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllBoostersForCharacterRMR:9 received msg: 0x7:49 GetAllBoostersForCharacterRMR { boosters: [] } 2:45:47.369 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:47.369 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllDecksForCharacterRMC:14 sending msg: 0x7:1c GetAllDecksForCharacterRMC 2:45:47.551 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:47.551 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:47.551 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:47.551 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllDecksForCharacterRMR:9 received msg: 0x7:43 GetAllDecksForCharacterRMR { decks: Decks { decks_size: 3 } } 2:45:47.558 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile .\\bf1\\map\\PVP\\12601_PvP_02p_Skjal2.map doesn\'t exist!" 2:45:47.558 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_1vs1 doesn\'t exist!" 2:45:47.558 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_2vs2 doesn\'t exist!" 2:45:47.558 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_1P doesn\'t exist!" 2:45:47.559 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_2P doesn\'t exist!" 2:45:47.559 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_4P doesn\'t exist!" 2:45:47.559 INFO 13764 proxy::logging:72 src="PG (PREGAME)" message="The mapfile UGM_DummyMap_3vs3 doesn\'t exist!" 2:45:48.172 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:48.172 DEBUG 9952 sr_packet::from_game::matchmaking::MatchmakingMessage_GetFinishedMapsForCharacterRMC:7 sending msg: 0x8:42 GetFinishedMapsForCharacterRMC 2:45:48.336 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:48.336 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:48.336 DEBUG 9952 from_server::matchmaking::MatchmakingMessage_GetFinishedMapsForCharacterRMR:16 received msg: 0x8:58 GetFinishedMapsForCharacterRMR { maps: [FinishedMap { id: 67, difficulty: 1 }, FinishedMap { id: 45, difficulty: 1 }, FinishedMap { id: 8, difficulty: 1 }, FinishedMap { id: 57, difficulty: 1 }] } 2:45:48.347 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:48.348 DEBUG 9952 sr_packet::from_game::world::WorldMessage_GetFriendListRMC:7 sending msg: 0x4:7b GetFriendListRMC 2:45:48.510 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:48.511 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:48.511 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:48.511 DEBUG 9952 from_server::world::WorldMessage_GetFriendListRMR:9 received msg: 0x4:4e GetFriendListRMR { friends: [CNetWorldPlayerCompressedVO { guid: 57199, gold: 382, name: "aclundar", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -46 } }, state: 0, location: 0, map: NotAMap, experience: 678, elo: 0, highest_elo: 0 }, CNetWorldPlayerCompressedVO { guid: 57202, gold: 127, name: "Foxtrot", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -7 } }, state: 0, location: 0, map: NotAMap, experience: 267, elo: 0, highest_elo: 0 }] } 2:45:48.514 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:48.514 DEBUG 9952 sr_packet::from_game::world::WorldMessage_GetIgnoreListRMC:7 sending msg: 0x4:78 GetIgnoreListRMC 2:45:48.674 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:48.674 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:48.674 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:48.674 DEBUG 9952 from_server::world::WorldMessage_GetIgnoreListRMR:9 received msg: 0x4:4b GetIgnoreListRMR { ignores: [] } 2:45:48.688 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:48.688 DEBUG 9952 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 3, map: NotAMap } 2:45:48.848 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:48.848 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:48.848 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 3, players: [] } 2:45:48.854 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:48.854 DEBUG 9952 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 4, map: NotAMap } 2:45:49.013 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:49.013 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:49.013 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 4, players: [] } 2:45:49.019 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:49.019 DEBUG 9952 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 5, map: NotAMap } 2:45:49.178 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:49.179 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:49.179 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:49.179 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 5, players: [] } 2:45:49.185 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:49.185 DEBUG 9952 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 6, map: NotAMap } 2:45:49.344 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:49.344 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:49.344 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:49.344 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 6, players: [] } 2:45:49.349 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:49.349 DEBUG 9952 sr_packet::from_game::chat::ChatMessage_JoinChatRegionRMC:7 sending msg: 0x6:15 JoinChatRegionRMC { channel_type: 1, map: Introduction } 2:45:49.509 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:49.509 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:49.509 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:49.509 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionRMR:8 received msg: 0x6:1b JoinChatRegionRMR { channel: 1073, players: [JoinChatRegionPlayer { player: 4613, rank: 0, name: "Bini_Inibitor" }, JoinChatRegionPlayer { player: 52156, rank: 0, name: "Fayeth" }, JoinChatRegionPlayer { player: 57174, rank: 0, name: "Skippydamule" }] } 2:45:49.509 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:49.509 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:49.509 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 57174, gold: 25, name: "Skippydamule", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -8 } }, state: 0, location: 0, map: Introduction, experience: 1590, elo: 0, highest_elo: 0 } } 2:45:49.514 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:45:49.514 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:49.514 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 1, state: 1, map: NotAMap } 2:45:49.794 INFO 13764 proxy::logging:72 src="Pathing" message="Init Pathing Engine: Path finding (Feb 21 2013/13:42:45) \'_FINAL, _LIB, \'" 2:45:49.796 INFO 13764 proxy::logging:72 src="Pathing.Manager" message="CPathManagerConstructed" 2:45:49.927 INFO 13764 proxy::logging:72 src="VisManager" message="Loaded 4 different playercolors." 2:45:49.928 INFO 13764 proxy::logging:72 src="VisManager" message="Loaded 5 Flame Locator mappings" 2:45:49.928 INFO 13764 proxy::logging:72 src="VisManager" message="Loaded 3 Generator and 3 Monument descriptions" 2:45:49.931 INFO 13764 proxy::logging:72 src="CVisSoundWorldPlugin" message="Loaded 3 Reverb settings, defaults to bf1/sound/ir_presets/default.ifr with dry level 0.030000" 2:45:49.952 INFO 13764 proxy::logging:72 src="VisMain" message="Starting Build Scene..." 2:45:50.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:10] ShowTutorial 1" 2:45:50.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 2:45:51.126 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_section_browser.lub:275] Online Mode initialize!" 2:45:51.126 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_section_browser.lub:158] Initialize Persistent Views" 2:45:51.128 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_playerlist_controller.lub:64] PlayerListController:Update()" 2:45:51.128 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_playerlist_controller.lub:111] ClearList...PlayerListController" 2:45:51.128 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_playerlist_controller.lub:74] show playerlist" 2:45:51.128 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_playerlist_controller.lub:122] Adding a Character to the Playerlist" 2:45:51.140 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_playerlist_controller.lub:12] AddDelegates...PlayerListController..." 2:45:51.206 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:35] Initializing inventory controller." 2:45:51.206 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:59] Adding inventory controller delegates." 2:45:51.520 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:341] Toggling show inventory: 0" 2:45:51.521 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:349] Switching inventory tabs." 2:45:51.521 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:363] Switched to card tab." 2:45:51.526 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:163] Updating mode selection." 2:45:51.526 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 2:45:51.527 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:185] Cardpool found with id:1" 2:45:51.527 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:185] Cardpool found with id:2" 2:45:51.527 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:245] Updating inventory filter categories." 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:297] Resetting inventory filters." 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.528 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:45:51.529 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_inventory_controller.lub:237] Currency updated." 2:45:51.530 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:10] ShowTutorial 0" 2:45:51.530 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 2:45:51.530 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:10] ShowTutorial 7" 2:45:51.530 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 2:45:51.530 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:46] ...adding position" 2:45:51.537 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 2:45:51.537 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:10] ShowTutorial 6" 2:45:51.537 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 2:45:51.537 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:46] ...adding position" 2:45:51.537 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 2:45:51.546 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_deck_bar_controller.lub:13] Initializing deck bar controller." 2:45:51.547 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_deck_bar_controller.lub:22] Initializing deck bar delegates." 2:45:51.553 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_eventwindow_controller.lub:16] EventWindowController...Initialize" 2:45:51.553 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_eventwindow_controller.lub:18] ...done" 2:45:51.553 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_eventwindow_controller.lub:29] EventWindowController:AddDelegates()" 2:45:51.564 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [timed_task_manager.lub:12] Created new task RefreshPlayerRegionList" 2:45:51.564 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_player_location_search_controller.lub:46] Initialize...PlayerLocationSearchController..." 2:45:51.564 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_player_location_search_controller.lub:126] InitializeScreen...PlayerLocationSearchController..." 2:45:51.615 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_player_location_search_controller.lub:62] PlayerLocationSearchController...AddDelegates..." 2:45:51.668 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:11] [pg_navigation_controller.lub:189] Checking for new mail ... checkServer=1" 2:45:51.670 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:51.670 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 sending msg: 0x7:14 GetInGameMailRMC 2:45:51.832 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:51.832 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:51.832 DEBUG 9952 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 received msg: 0x7:3c GetInGameMailRMR { mails: [] } 2:45:51.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 2:45:51.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:16] AddDelegates...NavigationController" 2:45:51.834 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:278] After Persistent Views initializing!" 2:45:51.834 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to News" 2:45:51.834 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Login\'" 2:45:51.834 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'News\'" 2:45:51.834 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/news/pg_news_view.xml" 2:45:51.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section.lub:30] PregameSection.Open" 2:45:51.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 2:45:51.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section.lub:41] PregameSection.Open: Initialize controller" 2:45:51.913 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:51.913 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetCharacterStatisticRMC:14 sending msg: 0x7:1e GetCharacterStatisticRMC 2:45:52.077 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:52.077 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:52.077 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:52.078 DEBUG 9952 from_server::pregame::PreGameMessage_GetCharacterStatisticRMR:9 received msg: 0x7:46 GetCharacterStatisticRMR { wins: [4, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 0, 6, 0, 0, 2, 0, 0, 13, 0, 2, 0, 0, 0], stats: [0, 0, 0, 0, 0, 0, 0, 0, 0, 0], cards: 145, elo: 0 } 2:45:52.094 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{f}\t0" 2:45:52.094 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:133] Request with id 9 was sent!" 2:45:52.094 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:586] NewsController:SwitchTab(2)" 2:45:52.094 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:184] NewsController:Initialize() " 2:45:52.095 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section.lub:50] Show ActiveView" 2:45:52.095 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to News" 2:45:52.095 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [timed_task_manager.lub:15] Created new anonymous task" 2:45:52.095 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_inventory_view State: 1" 2:45:52.095 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_playerlist_view State: 1" 2:45:52.095 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_navigation_view State: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_deck_bar_view State: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_request_list_view State: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_public_chatwindow_wnd State: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_ls_playerlist_view State: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:110] Hiding persistent View: pg_private_chatwindow_wnd State: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:132] ShowPregameSections" 2:45:52.096 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:45:52.098 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:52.098 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_GetQuests:16 sending msg: 0x1:f GetQuests { request: 9, language: 48 } 2:45:52.099 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:45:52.099 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 2:45:52.099 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_section_browser.lub:264] Deckbuilder Loaded!" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:650] DeckBarController:OnPregame" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:257] Attempt at toggling deckbar status. New status 1" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:273] Did not toggle deckbar active status" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:660] Inializing deck slots." 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_inventory_controller.lub:212] Current deck changed." 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:279] Deck changed to Nature Frost" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:598] Toggled deck edit mode. New status 0" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Nature Frost" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:169] Updating lock deck button" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:215] Updating deck name" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:298] Resetting all card slots" 2:45:52.099 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:223] Updating card slots" 2:45:52.100 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:202] Updating cover card" 2:45:52.102 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_deck_bar_controller.lub:183] Updating new deck button" 2:45:52.114 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:105] Set ExitBtnState 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:137] Change contacts button icon" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:129] We are in the sandbox and need to change PushButtonStates" 2:45:52.115 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_navigation_controller.lub:133] Set SectionsPushButton state 1" 2:45:52.263 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:45:52.263 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:45:52.263 TRACE 9952 sr_packet::from_game::extensions:114 Splitting packet to 2 parts 2:45:52.263 WARN 9952 proxy::networking::connect:803 LOGIN: 6.0735751s 2:45:52.263 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:45:52.263 DEBUG 9952 from_server::chat::ChatMessage_SystemNotification:8 received msg: 0x6:b SystemNotification { message: "\u{1}\t\u{0}\u{1}{\"Achievements\":[{\"CanBeRerolled\":false,\"Goal\":5.0,\"Id\":1.0,\"Progress\":4.0,\"RewardBFP\":0.0,\"RewardBooster\":1.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"NextQuestIn\":26100.0,\"Quests\":[{\"CanBeRerolled\":true,\"Goal\":3.0,\"Id\":3.0,\"Progress\":1.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"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\":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\":1.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCar" } 2:45:52.263 DEBUG 9952 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\":140.0,\"DailyBoostPlayTimeLeft\":2016.0,\"Reserve\":200.0}}" } 2:45:52.266 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:65] Header:9|1|2" 2:45:52.266 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:66] Data:{\"Achievements\":[{\"CanBeRerolled\":false,\"Goal\":5.0,\"Id\":1.0,\"Progress\":4.0,\"RewardBFP\":0.0,\"RewardBooster\":1.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"NextQuestIn\":26100.0,\"Quests\":[{\"CanBeRerolled\":true,\"Goal\":3.0,\"Id\":3.0,\"Progress\":1.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"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\":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\":1.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCar" 2:45:52.266 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:65] Header:9|2|2" 2:45:52.266 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:66] Data:ds\":[],\"RewardXP\":0.0}],\"ReRollAvailable\":true,\"TimeRewards\":{\"DailyBoost\":140.0,\"DailyBoostPlayTimeLeft\":2016.0,\"Reserve\":200.0}}" 2:45:52.266 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:74] Received all request packets for request 9" 2:45:52.266 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_packet_listener.lub:75] Combined data: {\"Achievements\":[{\"CanBeRerolled\":false,\"Goal\":5.0,\"Id\":1.0,\"Progress\":4.0,\"RewardBFP\":0.0,\"RewardBooster\":1.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"NextQuestIn\":26100.0,\"Quests\":[{\"CanBeRerolled\":true,\"Goal\":3.0,\"Id\":3.0,\"Progress\":1.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0},{\"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\":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\":1.0,\"RewardBFP\":75.0,\"RewardBooster\":0.0,\"RewardCards\":[],\"RewardXP\":0.0}],\"ReRollAvailable\":true,\"TimeRewards\":{\"DailyBoost\":140.0,\"DailyBoostPlayTimeLeft\":2016.0,\"Reserve\":200.0}}" 2:45:52.274 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 1" 2:45:52.295 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 3" 2:45:52.305 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 5" 2:45:52.315 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 8" 2:45:52.324 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 11" 2:45:52.334 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:12] [pg_news_controller.lub:786] Created quest/achievement entry with ID: 4" 2:45:55.565 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 2:45:55.565 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'News\'" 2:45:55.565 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 2:45:55.565 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:293] Activate Deckbuiler" 2:45:55.566 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 2:45:55.566 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:45:55.566 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:136] HidePregameSections" 2:45:55.567 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:45:55.567 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_tutorial_helper.lub:10] ShowTutorial 1" 2:45:55.567 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:15] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 2:45:57.566 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:17] [pg_inventory_controller.lub:445] Attempting to toggle inventory." 2:45:57.566 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:17] [pg_inventory_controller.lub:457] Can toggle because of correct sections. New inventory state:1" 2:45:57.566 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:00:17] [pg_inventory_controller.lub:341] Toggling show inventory: 1" 2:46:56.158 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Marketplace" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:302] DeActivate Deckbuiler" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:132] ShowPregameSections" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Marketplace\'" 2:46:56.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/marketplace/pg_marketplace_view.xml" 2:46:56.206 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:10] ShowTutorial 35" 2:46:56.206 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 2:46:56.234 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:10] ShowTutorial 36" 2:46:56.234 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 2:46:56.234 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:46] ...adding position" 2:46:56.236 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 2:46:56.244 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:10] ShowTutorial 38" 2:46:56.244 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 2:46:56.244 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:46] ...adding position" 2:46:56.245 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 2:46:56.251 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:10] ShowTutorial 32" 2:46:56.251 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 2:46:56.251 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:46] ...adding position" 2:46:56.252 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 2:46:56.255 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section.lub:30] PregameSection.Open" 2:46:56.255 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 2:46:56.255 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_section.lub:41] PregameSection.Open: Initialize controller" 2:46:56.263 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:46:56.263 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:46:56.263 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 3, state: 1, map: NotAMap } 2:46:56.275 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:46:56.275 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllProductsRMC:7 sending msg: 0x3:11 GetAllProductsRMC 2:46:56.584 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:46:56.584 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:46:56.585 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:46:56.585 DEBUG 9952 from_server::shop::ShopMessage_GetAllProductsRMR:42 received msg: 0x3:23 GetAllProductsRMR { products: [Product { id: 2, name: "Stonekin", edition: 2, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 3, name: "Twilight", edition: 3, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 4, name: "Bandits", edition: 4, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 5, name: "LostSouls", edition: 5, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 7, name: "AllEditions", edition: 7, cost: 450, bundled_products: [], bundled_editions: [] }, Product { id: 8, name: "Fire", edition: 8, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 9, name: "Frost", edition: 9, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 10, name: "Nature", edition: 10, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 11, name: "Shadow", edition: 11, cost: 1000, bundled_products: [], bundled_editions: [] }] } 2:46:56.597 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 7 Edition: 7 Price: 450" 2:46:56.604 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 2)" 2:46:56.604 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 1)" 2:46:56.605 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 5 Edition: 5 Price: 700" 2:46:56.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 2)" 2:46:56.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 1)" 2:46:56.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 4 Edition: 4 Price: 700" 2:46:56.616 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 2)" 2:46:56.616 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 1)" 2:46:56.618 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 2 Edition: 2 Price: 700" 2:46:56.623 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 2)" 2:46:56.623 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 1)" 2:46:56.624 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 3 Edition: 3 Price: 700" 2:46:56.629 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 2)" 2:46:56.629 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 1)" 2:46:56.629 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 10 Edition: 10 Price: 1000" 2:46:56.634 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 2)" 2:46:56.634 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 1)" 2:46:56.635 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 9 Edition: 9 Price: 1000" 2:46:56.641 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 2)" 2:46:56.641 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 1)" 2:46:56.641 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 8 Edition: 8 Price: 1000" 2:46:56.646 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 2)" 2:46:56.646 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 1)" 2:46:56.647 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:328] Booster id: 11 Edition: 11 Price: 1000" 2:46:56.652 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 2)" 2:46:56.652 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:16] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 1)" 2:46:56.658 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:46:56.658 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetMyWatchListRMC:7 sending msg: 0x3:b GetMyWatchListRMC 2:46:56.820 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:46:56.820 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:46:56.820 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:46:56.820 DEBUG 9952 from_server::shop::ShopMessage_GetMyWatchListRMR:42 received msg: 0x3:1d GetMyWatchListRMR { auctions: Auctions { auctions_size: 0 } } 2:46:56.820 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{1f}\n" 2:46:56.820 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_packet_listener.lub:133] Request with id 10 was sent!" 2:46:56.820 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_section.lub:50] Show ActiveView" 2:46:56.825 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:46:56.825 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_CustomPacket:16 sending msg: 0x1:1 CustomPacket { lua_data: "\u{1f}\n" } 2:46:56.986 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:46:56.986 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:46:56.986 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:46:56.986 DEBUG 9952 from_server::chat::ChatMessage_SystemNotification:8 received msg: 0x6:b SystemNotification { message: "\u{1}\n\u{0}\u{0}{\"Progress\":1584, \"HasDiscount\": false}" } 2:46:56.989 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_packet_listener.lub:65] Header:10|1|1" 2:46:56.989 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_packet_listener.lub:66] Data:{\"Progress\":1584, \"HasDiscount\": false}" 2:46:56.989 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_packet_listener.lub:74] Received all request packets for request 10" 2:46:56.989 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:01:17] [pg_packet_listener.lub:75] Combined data: {\"Progress\":1584, \"HasDiscount\": false}" 2:47:04.062 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:47:04.062 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 3, descending: false, page_size: 25, page_number: 0, cards: ["Deepcoil Worm"] } 2:47:04.230 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:47:04.231 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:47:04.231 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:47:04.231 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 10 }, total_auctions: 10 } 2:47:06.824 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:47:06.824 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Deepcoil Worm"] } 2:47:06.994 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:47:06.994 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:47:06.994 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 10 }, total_auctions: 10 } 2:47:08.552 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:47:08.552 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 3, descending: false, page_size: 25, page_number: 0, cards: ["Deepcoil Worm"] } 2:47:08.720 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:47:08.720 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:47:08.720 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:47:08.720 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 10 }, total_auctions: 10 } 2:47:16.802 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:47:16.802 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 3, descending: false, page_size: 25, page_number: 0, cards: ["Deepfang", "Deepfang"] } 2:47:16.974 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:47:16.975 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:47:16.975 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:47:16.975 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 18 }, total_auctions: 18 } 2:49:08.190 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:49:08.190 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 3, descending: false, page_size: 25, page_number: 0, cards: ["Ashbone Pyro"] } 2:49:08.360 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:49:08.361 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:49:08.361 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:49:08.361 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 7 }, total_auctions: 7 } 2:49:10.730 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:49:10.730 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Ashbone Pyro"] } 2:49:10.897 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:49:10.897 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:49:10.897 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:49:10.897 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 7 }, total_auctions: 7 } 2:49:13.455 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 2:49:13.455 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Marketplace\'" 2:49:13.457 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:49:13.458 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:49:13.458 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 2:49:13.459 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 2:49:13.459 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:293] Activate Deckbuiler" 2:49:13.460 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 2:49:13.460 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:49:13.460 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:136] HidePregameSections" 2:49:13.460 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:49:13.460 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_tutorial_helper.lub:10] ShowTutorial 1" 2:49:13.460 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:03:33] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 2:50:30.987 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Marketplace" 2:50:30.987 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 2:50:30.987 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:302] DeActivate Deckbuiler" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:132] ShowPregameSections" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Marketplace\'" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section.lub:30] PregameSection.Open" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 2:50:30.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section.lub:41] PregameSection.Open: Initialize controller" 2:50:30.988 ERROR 13764 proxy::networking::connect:190 BUG, this should never happen, packet is already expected 2:50:30.990 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:50:30.990 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:50:30.990 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 3, state: 1, map: NotAMap } 2:50:31.002 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:50:31.002 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllProductsRMC:7 sending msg: 0x3:11 GetAllProductsRMC 2:50:31.324 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:50:31.324 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:50:31.324 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:50:31.324 DEBUG 9952 from_server::shop::ShopMessage_GetAllProductsRMR:42 received msg: 0x3:23 GetAllProductsRMR { products: [Product { id: 2, name: "Stonekin", edition: 2, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 3, name: "Twilight", edition: 3, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 4, name: "Bandits", edition: 4, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 5, name: "LostSouls", edition: 5, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 7, name: "AllEditions", edition: 7, cost: 450, bundled_products: [], bundled_editions: [] }, Product { id: 8, name: "Fire", edition: 8, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 9, name: "Frost", edition: 9, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 10, name: "Nature", edition: 10, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 11, name: "Shadow", edition: 11, cost: 1000, bundled_products: [], bundled_editions: [] }] } 2:50:31.334 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 7 Edition: 7 Price: 450" 2:50:31.340 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 2)" 2:50:31.340 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 1)" 2:50:31.340 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 5 Edition: 5 Price: 700" 2:50:31.346 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 2)" 2:50:31.346 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 1)" 2:50:31.346 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 4 Edition: 4 Price: 700" 2:50:31.352 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 2)" 2:50:31.352 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 1)" 2:50:31.352 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 2 Edition: 2 Price: 700" 2:50:31.358 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 2)" 2:50:31.358 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 1)" 2:50:31.359 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 3 Edition: 3 Price: 700" 2:50:31.365 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 2)" 2:50:31.365 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 1)" 2:50:31.365 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 10 Edition: 10 Price: 1000" 2:50:31.371 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 2)" 2:50:31.371 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 1)" 2:50:31.371 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 9 Edition: 9 Price: 1000" 2:50:31.377 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 2)" 2:50:31.377 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 1)" 2:50:31.377 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 8 Edition: 8 Price: 1000" 2:50:31.383 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 2)" 2:50:31.383 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 1)" 2:50:31.383 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:328] Booster id: 11 Edition: 11 Price: 1000" 2:50:31.389 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 2)" 2:50:31.389 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 1)" 2:50:31.389 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{1f}\u{b}" 2:50:31.389 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_packet_listener.lub:133] Request with id 11 was sent!" 2:50:31.389 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_section.lub:50] Show ActiveView" 2:50:31.399 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:50:31.399 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_CustomPacket:16 sending msg: 0x1:1 CustomPacket { lua_data: "\u{1f}\u{b}" } 2:50:31.567 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:50:31.567 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:50:31.567 DEBUG 9952 from_server::chat::ChatMessage_SystemNotification:8 received msg: 0x6:b SystemNotification { message: "\u{1}\u{b}\u{0}\u{0}{\"Progress\":1584, \"HasDiscount\": false}" } 2:50:31.569 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_packet_listener.lub:65] Header:11|1|1" 2:50:31.569 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_packet_listener.lub:66] Data:{\"Progress\":1584, \"HasDiscount\": false}" 2:50:31.569 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_packet_listener.lub:74] Received all request packets for request 11" 2:50:31.569 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:04:51] [pg_packet_listener.lub:75] Combined data: {\"Progress\":1584, \"HasDiscount\": false}" 2:50:39.153 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:50:39.153 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Soulhunter", "Soulhunter"] } 2:50:39.327 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:50:39.327 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:50:39.327 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 25 }, total_auctions: 27 } 2:52:34.031 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:52:34.031 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:52:34.031 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 966, gold: 45, name: "Uriaro", rank: 0, avatar: Card { card: "Firedancer" }, state: 0, location: 0, map: Introduction, experience: 189616, elo: 0, highest_elo: 0 } } 2:52:44.659 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:52:44.659 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:52:44.659 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:52:44.659 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 54909, gold: 7308, name: "Unit22", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -40 } }, state: 0, location: 0, map: Introduction, experience: 148558, elo: 0, highest_elo: 0 } } 2:52:48.554 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:52:48.554 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:52:48.554 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 966 } 2:52:57.824 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:52:57.824 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Corsair", "Corsair"] } 2:52:57.993 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:52:57.993 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:52:57.993 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:52:57.993 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 16 }, total_auctions: 16 } 2:53:16.142 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:53:16.142 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 3, descending: false, page_size: 25, page_number: 0, cards: ["Corsair", "Corsair"] } 2:53:16.312 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:53:16.312 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:53:16.312 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:53:16.312 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 16 }, total_auctions: 16 } 2:53:18.913 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:53:18.913 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Corsair", "Corsair"] } 2:53:19.083 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:53:19.083 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:53:19.083 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 16 }, total_auctions: 16 } 2:53:21.467 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:53:21.467 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:53:21.467 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 54909 } 2:53:48.204 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 2:53:48.204 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Marketplace\'" 2:53:48.206 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:53:48.206 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:53:48.206 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 2:53:48.208 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 2:53:48.208 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:293] Activate Deckbuiler" 2:53:48.209 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 2:53:48.209 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:53:48.209 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:136] HidePregameSections" 2:53:48.209 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:53:48.209 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_tutorial_helper.lub:10] ShowTutorial 1" 2:53:48.209 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:08] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 2:53:51.784 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:12] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:53:52.472 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:12] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:53:53.659 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:13] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:53:54.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:14] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:53:55.002 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:08:15] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:56:48.207 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:56:48.207 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_KeepAliveAction:16 sending msg: 0x1:7 KeepAliveAction 2:56:50.843 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:56:50.843 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:56:50.843 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:56:50.843 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 52156 } 2:57:09.900 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:57:09.900 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:57:09.900 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 56934, gold: 750, name: "JAWS", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -12 } }, state: 0, location: 0, map: Introduction, experience: 19096, elo: 0, highest_elo: 0 } } 2:57:10.955 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:11:31] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:57:11.471 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:11:31] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:05.911 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:58:05.911 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:58:05.911 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 4613 } 2:58:15.705 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Marketplace" 2:58:15.705 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 2:58:15.705 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:302] DeActivate Deckbuiler" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:124] Deckbuilder is ParentView" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:132] ShowPregameSections" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Marketplace\'" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section.lub:30] PregameSection.Open" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 2:58:15.706 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:35] [pg_section.lub:41] PregameSection.Open: Initialize controller" 2:58:15.706 ERROR 13764 proxy::networking::connect:190 BUG, this should never happen, packet is already expected 2:58:15.710 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 2:58:15.710 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:58:15.710 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 3, state: 1, map: NotAMap } 2:58:15.721 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:58:15.721 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllProductsRMC:7 sending msg: 0x3:11 GetAllProductsRMC 2:58:16.031 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:58:16.031 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:58:16.031 DEBUG 9952 from_server::shop::ShopMessage_GetAllProductsRMR:42 received msg: 0x3:23 GetAllProductsRMR { products: [Product { id: 2, name: "Stonekin", edition: 2, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 3, name: "Twilight", edition: 3, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 4, name: "Bandits", edition: 4, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 5, name: "LostSouls", edition: 5, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 7, name: "AllEditions", edition: 7, cost: 450, bundled_products: [], bundled_editions: [] }, Product { id: 8, name: "Fire", edition: 8, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 9, name: "Frost", edition: 9, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 10, name: "Nature", edition: 10, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 11, name: "Shadow", edition: 11, cost: 1000, bundled_products: [], bundled_editions: [] }] } 2:58:16.041 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 7 Edition: 7 Price: 450" 2:58:16.047 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 2)" 2:58:16.047 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 1)" 2:58:16.047 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 5 Edition: 5 Price: 700" 2:58:16.054 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 2)" 2:58:16.054 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 1)" 2:58:16.054 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 4 Edition: 4 Price: 700" 2:58:16.060 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 2)" 2:58:16.060 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 1)" 2:58:16.060 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 2 Edition: 2 Price: 700" 2:58:16.066 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 2)" 2:58:16.066 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 1)" 2:58:16.066 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 3 Edition: 3 Price: 700" 2:58:16.072 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 2)" 2:58:16.072 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 1)" 2:58:16.072 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 10 Edition: 10 Price: 1000" 2:58:16.078 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 2)" 2:58:16.078 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 1)" 2:58:16.078 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 9 Edition: 9 Price: 1000" 2:58:16.084 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 2)" 2:58:16.084 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 1)" 2:58:16.084 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 8 Edition: 8 Price: 1000" 2:58:16.090 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 2)" 2:58:16.090 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 1)" 2:58:16.090 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:328] Booster id: 11 Edition: 11 Price: 1000" 2:58:16.097 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 2)" 2:58:16.097 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 1)" 2:58:16.097 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{1f}\u{c}" 2:58:16.097 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_packet_listener.lub:133] Request with id 12 was sent!" 2:58:16.097 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_section.lub:50] Show ActiveView" 2:58:16.107 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:58:16.107 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_CustomPacket:16 sending msg: 0x1:1 CustomPacket { lua_data: "\u{1f}\u{c}" } 2:58:16.268 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:58:16.268 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:58:16.268 DEBUG 9952 from_server::chat::ChatMessage_SystemNotification:8 received msg: 0x6:b SystemNotification { message: "\u{1}\u{c}\u{0}\u{0}{\"Progress\":1584, \"HasDiscount\": false}" } 2:58:16.269 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_packet_listener.lub:65] Header:12|1|1" 2:58:16.270 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_packet_listener.lub:66] Data:{\"Progress\":1584, \"HasDiscount\": false}" 2:58:16.270 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_packet_listener.lub:74] Received all request packets for request 12" 2:58:16.270 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:36] [pg_packet_listener.lub:75] Combined data: {\"Progress\":1584, \"HasDiscount\": false}" 2:58:21.619 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:58:21.619 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Skyfire Drake"] } 2:58:21.790 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:58:21.790 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:58:21.790 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 8 }, total_auctions: 8 } 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:297] Resetting inventory filters." 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:58:37.410 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 2:58:38.361 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:58] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:38.801 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:59] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:58:39.627 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:12:59] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 2:59:33.664 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:59:33.664 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 3, descending: false, page_size: 25, page_number: 0, cards: ["Skyfire Drake"] } 2:59:33.833 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:59:33.833 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:59:33.833 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:59:33.833 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 8 }, total_auctions: 8 } 2:59:35.105 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 2:59:35.105 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Skyfire Drake"] } 2:59:35.272 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:59:35.272 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:59:35.272 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:59:35.272 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 8 }, total_auctions: 8 } 2:59:39.026 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 2:59:39.026 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:59:39.026 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:59:39.028 DEBUG 9952 from_server::chat::ChatMessage_SayNotification:8 received msg: 0x6:d SayNotification { channel: 3, state: 1, location: 2, player: 57009, player_name: "Oxzde", message: "Selling Disenchant(G)-1440(160 cheaper than AH->accepting trades(frost/naature)" } 2:59:48.471 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 2:59:48.472 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 2:59:48.472 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 57213, gold: 58, name: "serse", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -6 } }, state: 0, location: 0, map: Introduction, experience: 983, elo: 0, highest_elo: 0 } } 3:00:03.147 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:00:03.147 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:00:03.147 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 57213 } 3:01:25.979 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:01:25.979 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:01:25.979 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 56934 } 3:01:32.246 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:01:32.246 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Soulhunter", "Soulhunter"] } 3:01:32.419 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:01:32.420 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:01:32.420 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:01:32.420 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 25 }, total_auctions: 27 } 3:04:06.000 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:06.000 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_BuyoutAuctionRMC:7 sending msg: 0x3:d BuyoutAuctionRMC { auction: 2574255 } 3:04:06.173 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:06.173 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:06.175 DEBUG 9952 from_server::shop::ShopMessage_MailNotification:42 received msg: 0x3:2 MailNotification { player: 57174, count: 1 } 3:04:06.175 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:06.175 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:06.175 DEBUG 9952 from_server::shop::ShopMessage_BuyoutAuctionRMR:42 received msg: 0x3:1f BuyoutAuctionRMR { error: 0 } 3:04:06.176 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:26] [pg_inventory_controller.lub:237] Currency updated." 3:04:06.188 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:06.188 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Soulhunter", "Soulhunter"] } 3:04:06.360 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:04:06.361 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:06.361 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:06.361 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 25 }, total_auctions: 26 } 3:04:06.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:26] [pg_navigation_controller.lub:217] Mail Notification received ... unreadMailCount=1" 3:04:06.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:26] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 3:04:08.222 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Mail" 3:04:08.222 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Marketplace\'" 3:04:08.233 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 3:04:08.233 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:08.233 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 3:04:08.235 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Mail\'" 3:04:08.235 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/mail/pg_mail_view.xml" 3:04:08.293 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_tutorial_helper.lub:10] ShowTutorial 42" 3:04:08.293 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 3:04:08.293 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_tutorial_helper.lub:10] ShowTutorial 43" 3:04:08.293 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 3:04:08.293 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_tutorial_helper.lub:46] ...adding position" 3:04:08.296 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 3:04:08.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section.lub:30] PregameSection.Open" 3:04:08.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 3:04:08.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section.lub:41] PregameSection.Open: Initialize controller" 3:04:08.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:37] Initializing mail controller." 3:04:08.302 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:894] Clearing mail text input fields." 3:04:08.302 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:886] Updating mail text input fields with latest values." 3:04:08.302 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:338] Attempting to switch to screen 1" 3:04:08.302 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:878] Storing current mail text input fields." 3:04:08.302 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:350] Switched to mail inbox tab." 3:04:08.302 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:237] Updating mail inbox." 3:04:08.311 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:08.311 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 sending msg: 0x7:14 GetInGameMailRMC 3:04:08.602 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:04:08.603 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:08.603 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:08.603 DEBUG 9952 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 received msg: 0x7:3c GetInGameMailRMR { mails: [Mail { id: 6860963, sender: None, header: "", body: "", cards: ["Soulhunter"], mail_type: 2, boosters: [], creation_date: 1599361445, gold: 0, type_: 1, bfp: 0, collected: false, auction_card: "Soulhunter", auction_bfp: 29 }] } 3:04:08.604 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:240] Fetched mails from server." 3:04:08.605 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:251] Updated single mail. IsEAMail:1 From: Subject:Congratulations you have won the bid for Soulhunter… Date:09/05/2020 Type:2 State:1" 3:04:08.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 3:04:08.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:224] Inventory updated." 3:04:08.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:163] Updating mode selection." 3:04:08.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 3:04:08.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:185] Cardpool found with id:1" 3:04:08.610 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:185] Cardpool found with id:2" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Nature Frost" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:169] Updating lock deck button" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:215] Updating deck name" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:298] Resetting all card slots" 3:04:08.611 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:223] Updating card slots" 3:04:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_deck_bar_controller.lub:202] Updating cover card" 3:04:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:162] Updating mail attachments." 3:04:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 3:04:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_mail_controller.lub:886] Updating mail text input fields with latest values." 3:04:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:28] [pg_section.lub:50] Show ActiveView" 3:04:09.642 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:29] [pg_mail_controller.lub:862] Updating read button state." 3:04:09.830 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:395] Reading a mail..." 3:04:09.830 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 3:04:09.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:463] Updated single mail. IsEAMail:1 From: Subject:Congratulations you have won the bid for Soulhunter… Date:09/05/2020 Type:2 State:1 Cards:1 Boosters:0 BFP:0" 3:04:09.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:222] Attempting to disable new mail FX" 3:04:09.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:217] Unread mail count is 1" 3:04:09.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:338] Attempting to switch to screen 3" 3:04:09.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:878] Storing current mail text input fields." 3:04:09.833 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:30] [pg_mail_controller.lub:386] Switched to read mail tab." 3:04:11.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:31] [pg_mail_controller.lub:510] Trying to collect items from mail:0 CollectedOnDelete:0" 3:04:11.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:31] [pg_mail_controller.lub:518] Mail had attachments. Attempting to read it." 3:04:11.302 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:11.302 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_OpenInGameMailRMC:14 sending msg: 0x7:12 OpenInGameMailRMC { mail: 6860963 } 3:04:11.481 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:04:11.481 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:11.481 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:11.483 DEBUG 9952 from_server::pregame::PreGameMessage_OpenInGameMailRMR:9 received msg: 0x7:3a OpenInGameMailRMR { error: 0 } 3:04:11.483 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:31] [pg_mail_controller.lub:522] Read mail with errorcode: 0" 3:04:11.483 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:31] [pg_inventory_controller.lub:237] Currency updated." 3:04:11.483 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:31] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 3:04:11.490 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllLimitedPoolsForCharacterRMR:9 received msg: 0x7:37 GetAllLimitedPoolsForCharacterRMR 3:04:11.500 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:11.500 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMC:14 sending msg: 0x7:26 GetAllCardsForCharacterCompressedRMC 3:04:11.684 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:04:11.685 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:11.686 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:11.686 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllCardsForCharacterCompressedRMR:9 received msg: 0x7:4e GetAllCardsForCharacterCompressedRMR { cards: CardsCompressed { cards_size: 118 } } 3:04:11.698 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:11.698 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMC:14 sending msg: 0x7:24 GetAllCardUpgradesForCharacterCompressedRMC 3:04:11.859 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:11.859 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:11.859 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllCardUpgradesForCharacterCompressedRMR:9 received msg: 0x7:4c GetAllCardUpgradesForCharacterCompressedRMR { upgrades: Upgrades { upgrades_size: 9 } } 3:04:11.863 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:11.863 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllBoostersForCharacterRMC:14 sending msg: 0x7:21 GetAllBoostersForCharacterRMC 3:04:12.023 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:12.023 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:12.023 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllBoostersForCharacterRMR:9 received msg: 0x7:49 GetAllBoostersForCharacterRMR { boosters: [] } 3:04:12.029 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:12.029 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetAllDecksForCharacterRMC:14 sending msg: 0x7:1c GetAllDecksForCharacterRMC 3:04:12.208 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:04:12.209 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:12.209 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:12.209 DEBUG 9952 from_server::pregame::PreGameMessage_GetAllDecksForCharacterRMR:9 received msg: 0x7:43 GetAllDecksForCharacterRMR { decks: Decks { decks_size: 3 } } 3:04:12.210 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:224] Inventory updated." 3:04:12.210 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:163] Updating mode selection." 3:04:12.210 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 3:04:12.211 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:185] Cardpool found with id:1" 3:04:12.211 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:185] Cardpool found with id:2" 3:04:12.211 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Nature Frost" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:169] Updating lock deck button" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:215] Updating deck name" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:298] Resetting all card slots" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:223] Updating card slots" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:202] Updating cover card" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [deck_utils.lub:12] RetrieveAllData: 1" 3:04:12.217 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_inventory_controller.lub:212] Current deck changed." 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:279] Deck changed to Nature Frost" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Nature Frost" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:169] Updating lock deck button" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:215] Updating deck name" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:298] Resetting all card slots" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:223] Updating card slots" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:202] Updating cover card" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_deck_bar_controller.lub:183] Updating new deck button" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_mail_controller.lub:530] Reloaded card data caused by mail deletion." 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_mail_controller.lub:222] Attempting to disable new mail FX" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_mail_controller.lub:217] Unread mail count is 0" 3:04:12.218 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:32] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 3:04:14.035 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:550] Deleting mail from inside mail." 3:04:14.035 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:567] Mail had items: 0. Succesfully collected them" 3:04:14.043 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:14.043 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_DeleteInGameMailRMC:14 sending msg: 0x7:11 DeleteInGameMailRMC { mail: 6860963 } 3:04:14.209 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:14.209 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:14.209 DEBUG 9952 from_server::pregame::PreGameMessage_DeleteInGameMailRMR:9 received msg: 0x7:39 DeleteInGameMailRMR { error: 0 } 3:04:14.210 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_inventory_controller.lub:237] Currency updated." 3:04:14.210 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_inventory_controller.lub:237] Currency updated." 3:04:14.210 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:570] Deleted mail from inside mail with errorCode:0" 3:04:14.214 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:338] Attempting to switch to screen 1" 3:04:14.214 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:878] Storing current mail text input fields." 3:04:14.214 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:350] Switched to mail inbox tab." 3:04:14.214 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:237] Updating mail inbox." 3:04:14.220 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:14.220 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_GetInGameMailRMC:14 sending msg: 0x7:14 GetInGameMailRMC 3:04:14.381 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:14.382 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:14.382 DEBUG 9952 from_server::pregame::PreGameMessage_GetInGameMailRMR:9 received msg: 0x7:3c GetInGameMailRMR { mails: [] } 3:04:14.384 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:34] [pg_mail_controller.lub:240] Fetched mails from server." 3:04:15.425 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Marketplace" 3:04:15.425 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Mail\'" 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_mail_controller.lub:878] Storing current mail text input fields." 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:224] Inventory updated." 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:163] Updating mode selection." 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: -1. Actual pool ID: 0" 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:185] Cardpool found with id:1" 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:185] Cardpool found with id:2" 3:04:15.426 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_inventory_controller.lub:264] Attempting to select cardpool by dropdown item index: 0. Actual pool ID: 1" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:126] Collection updated. Updating current deck" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Nature Frost" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:169] Updating lock deck button" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:215] Updating deck name" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:298] Resetting all card slots" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:223] Updating card slots" 3:04:15.427 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_deck_bar_controller.lub:202] Updating cover card" 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_mail_controller.lub:162] Updating mail attachments." 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_mail_controller.lub:24] Clearing all mail attachment proxies." 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_navigation_controller.lub:189] Checking for new mail ... checkServer=0" 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_navigation_controller.lub:179] NavigationController.ActivateNewMailFX" 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Marketplace\'" 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_section.lub:30] PregameSection.Open" 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 3:04:15.428 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:35] [pg_section.lub:41] PregameSection.Open: Initialize controller" 3:04:15.430 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 3:04:15.430 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:15.430 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 3, state: 1, map: NotAMap } 3:04:15.441 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:15.441 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllProductsRMC:7 sending msg: 0x3:11 GetAllProductsRMC 3:04:15.794 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:15.794 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:15.794 DEBUG 9952 from_server::shop::ShopMessage_GetAllProductsRMR:42 received msg: 0x3:23 GetAllProductsRMR { products: [Product { id: 2, name: "Stonekin", edition: 2, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 3, name: "Twilight", edition: 3, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 4, name: "Bandits", edition: 4, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 5, name: "LostSouls", edition: 5, cost: 700, bundled_products: [], bundled_editions: [] }, Product { id: 7, name: "AllEditions", edition: 7, cost: 450, bundled_products: [], bundled_editions: [] }, Product { id: 8, name: "Fire", edition: 8, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 9, name: "Frost", edition: 9, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 10, name: "Nature", edition: 10, cost: 1000, bundled_products: [], bundled_editions: [] }, Product { id: 11, name: "Shadow", edition: 11, cost: 1000, bundled_products: [], bundled_editions: [] }] } 3:04:15.806 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 7 Edition: 7 Price: 450" 3:04:15.812 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 2)" 3:04:15.812 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 7, 1)" 3:04:15.812 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 5 Edition: 5 Price: 700" 3:04:15.818 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 2)" 3:04:15.819 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 5, 1)" 3:04:15.819 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 4 Edition: 4 Price: 700" 3:04:15.825 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 2)" 3:04:15.825 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 4, 1)" 3:04:15.825 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 2 Edition: 2 Price: 700" 3:04:15.831 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 2)" 3:04:15.831 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 2, 1)" 3:04:15.831 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 3 Edition: 3 Price: 700" 3:04:15.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 2)" 3:04:15.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 3, 1)" 3:04:15.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 10 Edition: 10 Price: 1000" 3:04:15.844 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 2)" 3:04:15.844 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 10, 1)" 3:04:15.844 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 9 Edition: 9 Price: 1000" 3:04:15.850 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 2)" 3:04:15.850 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 9, 1)" 3:04:15.850 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 8 Edition: 8 Price: 1000" 3:04:15.857 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 2)" 3:04:15.857 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 8, 1)" 3:04:15.857 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:328] Booster id: 11 Edition: 11 Price: 1000" 3:04:15.863 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 2)" 3:04:15.863 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_marketplace_controller.lub:267] MarketplaceController:LookupDescField( 11, 1)" 3:04:15.863 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_packet_listener.lub:128] Sending command: \u{1}\u{8}\u{8}\u{1f}\r" 3:04:15.863 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_packet_listener.lub:133] Request with id 13 was sent!" 3:04:15.863 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_section.lub:50] Show ActiveView" 3:04:15.870 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:04:15.870 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_CustomPacket:16 sending msg: 0x1:1 CustomPacket { lua_data: "\u{1f}\r" } 3:04:16.031 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:04:16.031 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:04:16.031 DEBUG 9952 from_server::chat::ChatMessage_SystemNotification:8 received msg: 0x6:b SystemNotification { message: "\u{1}\r\u{0}\u{0}{\"Progress\":1584, \"HasDiscount\": false}" } 3:04:16.032 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_packet_listener.lub:65] Header:13|1|1" 3:04:16.032 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_packet_listener.lub:66] Data:{\"Progress\":1584, \"HasDiscount\": false}" 3:04:16.032 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_packet_listener.lub:74] Received all request packets for request 13" 3:04:16.032 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:36] [pg_packet_listener.lub:75] Combined data: {\"Progress\":1584, \"HasDiscount\": false}" 3:04:33.363 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:53] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:04:33.783 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:54] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:04:34.861 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:55] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:04:35.378 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:55] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:04:36.205 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:56] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:04:36.973 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:18:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:05:09.693 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:19:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:05:29.573 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:05:29.573 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Vileblood", "Vileblood"] } 3:05:29.739 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:05:29.739 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:05:29.739 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:05:29.739 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 6 }, total_auctions: 6 } 3:08:29.158 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:08:29.158 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:08:29.158 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:08:29.158 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 23138, gold: 182079, name: "ghostsree", rank: 0, avatar: Card { card: "Forest Elder" }, state: 0, location: 0, map: Introduction, experience: 1039195, elo: 0, highest_elo: 0 } } 3:08:29.574 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:08:29.574 DEBUG 9952 sr_packet::from_game::extensions::ExtensionCommands_KeepAliveAction:16 sending msg: 0x1:7 KeepAliveAction 3:08:54.433 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:08:54.434 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:08:54.434 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 47754, gold: 29576, name: "klutzz", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -3 } }, state: 0, location: 0, map: Introduction, experience: 116428, elo: 0, highest_elo: 0 } } 3:09:00.106 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:09:00.106 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:09:00.106 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:09:00.106 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 47754 } 3:09:09.162 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:09:09.162 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:09:09.162 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 23138 } 3:10:00.281 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:00.281 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:00.281 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 45446, gold: 1478, name: "Vibez", rank: 0, avatar: Card { card: "Forest Elder" }, state: 1, location: 2, map: Introduction, experience: 172603, elo: 0, highest_elo: 0 } } 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:297] Resetting inventory filters." 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:09.596 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:29] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:10.676 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:10.676 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:10.676 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 57152, gold: 634, name: "Reznovskii", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -16 } }, state: 0, location: 0, map: Introduction, experience: 2385, elo: 0, highest_elo: 0 } } 3:10:10.864 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:31] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:11.346 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:31] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:12.036 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:32] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:13.643 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:33] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:14.113 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:24:34] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:10:21.777 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:10:21.777 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:21.777 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:21.777 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 29330, gold: 87, name: "xinobyl", rank: 0, avatar: OldAvatar { old_avatar: OldAvatar { avatar: -13 } }, state: 0, location: 0, map: Introduction, experience: 45794, elo: 0, highest_elo: 0 } } 3:10:29.382 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:10:29.382 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:29.382 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:29.382 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 54949, gold: 1309, name: "Luplexia", rank: 0, avatar: Card { card: "Lost Reaver" }, state: 0, location: 0, map: Introduction, experience: 25206, elo: 0, highest_elo: 0 } } 3:10:38.167 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:10:38.167 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllAuctionsRMC:7 sending msg: 0x3:f GetAllAuctionsRMC { sort_by: 7, descending: false, page_size: 25, page_number: 0, cards: ["Lost Shade", "Lost Shade", "No card", "No card"] } 3:10:38.335 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:38.335 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:38.335 DEBUG 9952 from_server::shop::ShopMessage_GetAllAuctionsRMR:42 received msg: 0x3:21 GetAllAuctionsRMR { auctions: Auctions { auctions_size: 11 }, total_auctions: 11 } 3:10:47.003 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:47.003 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:47.003 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 29330 } 3:10:51.047 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:10:51.047 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:51.047 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:51.047 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 45446 } 3:10:54.276 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:10:54.276 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:10:54.276 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:10:54.276 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 54949 } 3:11:28.564 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:48] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:11:29.066 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:49] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:11:30.707 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:50] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:11:31.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:51] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:11:31.816 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:52] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:11:36.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 3:11:36.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Marketplace\'" 3:11:36.558 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 3:11:36.558 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:11:36.558 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 2, state: 1, map: NotAMap } 3:11:36.558 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 3:11:36.558 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:293] Activate Deckbuiler" 3:11:36.559 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 3:11:36.559 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:124] Deckbuilder is ParentView" 3:11:36.559 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:136] HidePregameSections" 3:11:36.559 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 3:11:36.559 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_tutorial_helper.lub:10] ShowTutorial 1" 3:11:36.559 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:25:56] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 3:11:58.313 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:11:58.313 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:11:58.313 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:11:58.313 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 55187, gold: 129307, name: "LTL", rank: 0, avatar: Card { card: "Mo" }, state: 0, location: 0, map: Introduction, experience: 212156, elo: 0, highest_elo: 0 } } 3:12:07.212 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 4 and self.size = 0 3:12:07.212 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:12:07.213 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:12:07.213 DEBUG 9952 from_server::chat::ChatMessage_SayNotification:8 received msg: 0x6:d SayNotification { channel: 4, state: 1, location: 4, player: 18214, player_name: "Janosch", message: "Bad harvest +1" } 3:13:02.487 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:27:22] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:13:03.112 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:27:23] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:13:23.316 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:27:43] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:13:23.800 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:27:44] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:01.549 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to DeckCreation" 3:14:01.549 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 3:14:01.549 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:302] DeActivate Deckbuiler" 3:14:01.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 3:14:01.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:124] Deckbuilder is ParentView" 3:14:01.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:132] ShowPregameSections" 3:14:01.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 3:14:01.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'DeckCreation\'" 3:14:01.550 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section.lub:76] Creating view bf1/ui/dialogs/pregame/limited_mode/pg_limited_create_new_deck_view.xml" 3:14:01.573 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section.lub:30] PregameSection.Open" 3:14:01.573 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 3:14:01.573 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section.lub:41] PregameSection.Open: Initialize controller" 3:14:01.573 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:21] [pg_section.lub:50] Show ActiveView" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [deck_utils.lub:89] Soul Hunter" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [deck_utils.lub:95] cardpool is nil" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_inventory_controller.lub:212] Current deck changed." 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:279] Deck changed to Soul Hunter" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Soul Hunter" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:169] Updating lock deck button" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:215] Updating deck name" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:298] Resetting all card slots" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:223] Updating card slots" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:202] Updating cover card" 3:14:14.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:183] Updating new deck button" 3:14:14.505 DEBUG 13764 proxy::game_config:212 network:lastuseddeck != Soul Hunter 3:14:14.508 ERROR 13764 proxy::networking::connect:190 BUG, this should never happen, packet is already expected 3:14:14.516 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:14:14.516 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_SaveDeckForCharacterRMC:14 sending msg: 0x7:1a SaveDeckForCharacterRMC { deck: 0, new_name: "Soul Hunter", cards: [], cover_card: 0, pool: 1 } 3:14:14.683 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:14:14.683 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:14:14.685 DEBUG 9952 from_server::pregame::PreGameMessage_SaveDeckForCharacterRMR:9 received msg: 0x7:41 SaveDeckForCharacterRMR { error: 0, guid: 466043, level: 0 } 3:14:14.686 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 1" 3:14:14.686 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_deck_bar_controller.lub:598] Toggled deck edit mode. New status 1" 3:14:14.690 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_inventory_controller.lub:465] Attempting to show inventory." 3:14:14.690 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_inventory_controller.lub:469] Showing inventory." 3:14:14.690 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_inventory_controller.lub:341] Toggling show inventory: 1" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'DeckCreation\'" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:293] Activate Deckbuiler" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:124] Deckbuilder is ParentView" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:136] HidePregameSections" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 3:14:14.691 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_tutorial_helper.lub:10] ShowTutorial 1" 3:14:14.692 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:34] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 3:14:16.753 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:36] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:17.207 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:37] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:18.830 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:39] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:19.736 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:39] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:22.785 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to DeckControl" 3:14:22.785 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 3:14:22.785 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:302] DeActivate Deckbuiler" 3:14:22.786 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 3:14:22.786 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:124] Deckbuilder is ParentView" 3:14:22.786 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:132] ShowPregameSections" 3:14:22.786 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 3:14:22.786 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'DeckControl\'" 3:14:22.786 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] Open Deck Control Section" 3:14:22.814 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:39] DeckControlController...Initialize" 3:14:22.814 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:41] ...done" 3:14:22.836 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:97] DeckControlController...CreateDeckControlList" 3:14:22.836 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 0" 3:14:22.836 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:164] Current deck name Soul Hunter with index 0" 3:14:22.836 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:237] UpdateInformation...DeckControlController..." 3:14:22.836 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:197] UpdateEditOptions...DeckControlController..." 3:14:22.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 1" 3:14:22.837 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 2" 3:14:22.838 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 3" 3:14:22.838 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:142] Creating Headline..." 3:14:22.839 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 4" 3:14:22.840 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:197] UpdateEditOptions...DeckControlController..." 3:14:22.840 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:57] AddDelegates...DeckControlController..." 3:14:22.845 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:97] DeckControlController...CreateDeckControlList" 3:14:22.845 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 0" 3:14:22.846 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 1" 3:14:22.846 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 2" 3:14:22.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 3" 3:14:22.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:164] Current deck name Soul Hunter with index 3" 3:14:22.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:237] UpdateInformation...DeckControlController..." 3:14:22.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:197] UpdateEditOptions...DeckControlController..." 3:14:22.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:142] Creating Headline..." 3:14:22.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 4" 3:14:22.848 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:197] UpdateEditOptions...DeckControlController..." 3:14:22.848 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_tutorial_helper.lub:10] ShowTutorial 27" 3:14:22.848 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_tutorial_helper.lub:43] ...adding delegate and questionmark widget!" 3:14:22.848 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_tutorial_helper.lub:46] ...adding position" 3:14:22.852 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_tutorial_helper.lub:77] ...detail view close delegate..." 3:14:22.855 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section.lub:30] PregameSection.Open" 3:14:22.855 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 3:14:22.855 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section.lub:41] PregameSection.Open: Initialize controller" 3:14:22.855 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_deck_control_controller.lub:39] DeckControlController...Initialize" 3:14:22.855 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:43] [pg_section.lub:50] Show ActiveView" 3:14:24.925 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:45] [pg_deck_control_controller.lub:282] OnDeckSelected...DeckControlController... Index: 4" 3:14:25.909 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:46] [pg_deck_control_controller.lub:360] OnBtnRename...DeckControlController..." 3:14:31.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:305] RenameDeck...DeckControlController..." 3:14:31.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:14:31.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:598] Toggled deck edit mode. New status 0" 3:14:31.854 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:14:31.856 DEBUG 9952 sr_packet::from_game::pregame::PreGameMessage_RenameDeckForCharacterRMC:14 sending msg: 0x7:18 RenameDeckForCharacterRMC { deck: 466043, new_name: "Soulhunter" } 3:14:32.020 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:14:32.020 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:14:32.020 DEBUG 9952 from_server::pregame::PreGameMessage_RenameDeckForCharacterRMR:9 received msg: 0x7:42 RenameDeckForCharacterRMR { error: 0 } 3:14:32.022 DEBUG 13764 proxy::game_config:212 network:lastuseddeck != Soulhunter 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [deck_suggest_storage.lua:22] Saving recent decks: {\"Skippydamule\":{\"Win Free BFP4\":[\"Nature Fire\",\"Eric\"],\"Siege of Hope1\":[\"Eric\"],\"Christmas Defense1\":[\"Eric\"],\"Bad Harvest4\":[\"Nature Fire\"],\"Introduction1\":[\"Tutorial\"],\"Defending Hope1\":[\"Nature Frost\"],\"Crusade2\":[\"Nature Fire\"],\"Encounters with Twilight1\":[\"Tutorial\"]}}" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_inventory_controller.lub:212] Current deck changed." 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:279] Deck changed to Soulhunter" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 0" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:594] Did not toggle deck edit mode" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:288] Updating deck bar with deck Soulhunter" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:169] Updating lock deck button" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:215] Updating deck name" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:298] Resetting all card slots" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:223] Updating card slots" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:202] Updating cover card" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_bar_controller.lub:183] Updating new deck button" 3:14:32.023 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:251] OnCurrentDeckChanged...DeckControlController..." 3:14:32.024 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:97] DeckControlController...CreateDeckControlList" 3:14:32.024 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 0" 3:14:32.025 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 1" 3:14:32.025 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 2" 3:14:32.026 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 3" 3:14:32.026 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:164] Current deck name Soulhunter with index 3" 3:14:32.026 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:237] UpdateInformation...DeckControlController..." 3:14:32.026 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:197] UpdateEditOptions...DeckControlController..." 3:14:32.026 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:142] Creating Headline..." 3:14:32.026 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:152] ...creating deck widget...deckindex: 4" 3:14:32.027 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:52] [pg_deck_control_controller.lub:197] UpdateEditOptions...DeckControlController..." 3:14:34.502 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Forge" 3:14:34.502 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'DeckControl\'" 3:14:34.502 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] Close Deck Control Section" 3:14:34.502 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Forge\'" 3:14:34.502 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:293] Activate Deckbuiler" 3:14:34.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 0" 3:14:34.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:124] Deckbuilder is ParentView" 3:14:34.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:136] HidePregameSections" 3:14:34.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 3:14:34.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_tutorial_helper.lub:10] ShowTutorial 1" 3:14:34.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_tutorial_helper.lub:39] Don\'t show tutorials, or tutorial already visited..." 3:14:34.509 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_deck_control_controller.lub:379] DeckControlController...Close..." 3:14:34.509 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_deck_control_controller.lub:380] ...Removing Delegates." 3:14:34.509 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_deck_control_controller.lub:78] RemoveDelegates...DeckControlController..." 3:14:34.509 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_deck_control_controller.lub:379] DeckControlController...Close..." 3:14:34.509 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_deck_control_controller.lub:380] ...Removing Delegates." 3:14:34.509 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_deck_control_controller.lub:78] RemoveDelegates...DeckControlController..." 3:14:34.512 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:54] [pg_tutorial_helper.lub:96] Tutorial Aborted: 27" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:297] Resetting inventory filters." 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Class" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:36.877 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:57] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:38.002 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:58] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:38.502 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:58] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:38.941 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:28:59] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:14:40.501 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:00] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:41.534 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:01] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:42.908 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:03] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:57.923 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:18] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:58.439 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:18] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:58.847 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:19] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:14:59.237 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:19] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:07.032 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:15:07.033 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:15:07.033 DEBUG 9952 from_server::chat::ChatMessage_LeaveChatRegionChannelNotification:8 received msg: 0x6:f LeaveChatRegionChannelNotification { channel: 1073, player: 57152 } 3:15:24.033 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:44] [pg_deck_bar_controller.lub:586] Attempting deck edit mode. New status 1" 3:15:24.033 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:44] [pg_deck_bar_controller.lub:598] Toggled deck edit mode. New status 1" 3:15:26.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:15:26.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:432] Slot found: 1" 3:15:26.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:446] Dropped middle" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [deck_utils.lub:52] Adding card to deck slot: 1 cardIndex: 116" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:638] Deck cover card changed" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:202] Updating cover card" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_inventory_controller.lub:497] Card added to deck. Collection index:116" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 116 to deck slot: 1" 3:15:26.504 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:46] [pg_deck_bar_controller.lub:202] Updating cover card" 3:15:29.378 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:49] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:29.908 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:50] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:30.113 DEBUG 9952 proxy::networking::connect:427 rf; target="threading::handle_packet_from_forge_server" 3:15:30.113 TRACE 9952 sr_packet::sr_packet_coder:43 Decode returned Ok(None). buf.len() = 0 and self.size = 0 3:15:30.113 DEBUG 9952 from_server::chat::ChatMessage_JoinChatRegionChannelNotification:8 received msg: 0x6:11 JoinChatRegionChannelNotification { channel: 1073, player: CNetWorldPlayerCompressedVO { guid: 56500, gold: 108, name: "Ryuksis10", rank: 0, avatar: Card { card: "Wheel of Gifts" }, state: 0, location: 0, map: Introduction, experience: 276441, elo: 0, highest_elo: 0 } } 3:15:30.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:50] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:31.581 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:51] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:15:32.019 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:52] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:15:32.642 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:52] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:15:35.535 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_deck_bar_controller.lub:432] Slot found: 4" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_deck_bar_controller.lub:446] Dropped middle" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [deck_utils.lub:52] Adding card to deck slot: 4 cardIndex: 115" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_inventory_controller.lub:497] Card added to deck. Collection index:115" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 115 to deck slot: 4" 3:15:35.536 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:29:55] [pg_deck_bar_controller.lub:202] Updating cover card" 3:15:40.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:15:40.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_deck_bar_controller.lub:432] Slot found: 2" 3:15:40.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_deck_bar_controller.lub:446] Dropped middle" 3:15:40.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:15:40.159 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [deck_utils.lub:52] Adding card to deck slot: 2 cardIndex: 5" 3:15:40.160 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_inventory_controller.lub:497] Card added to deck. Collection index:5" 3:15:40.160 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 5 to deck slot: 2" 3:15:40.160 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:00] [pg_deck_bar_controller.lub:202] Updating cover card" 3:15:43.361 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:15:43.361 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_deck_bar_controller.lub:432] Slot found: 3" 3:15:43.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_deck_bar_controller.lub:446] Dropped middle" 3:15:43.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:15:43.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [deck_utils.lub:52] Adding card to deck slot: 3 cardIndex: 42" 3:15:43.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_inventory_controller.lub:497] Card added to deck. Collection index:42" 3:15:43.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 42 to deck slot: 3" 3:15:43.362 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:03] [pg_deck_bar_controller.lub:202] Updating cover card" 3:15:50.503 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:10] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:15:51.142 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:11] [pg_inventory_controller.lub:254] Toggling inventory filter property: Token" 3:15:52.173 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:12] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:15:52.579 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:12] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:15:53.142 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:13] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:15:55.674 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:15] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:56.066 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:16] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:56.487 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:16] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:57.892 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:18] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:15:58.299 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:18] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:16:01.768 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:21] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:16:02.331 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:22] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:16:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:16:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_deck_bar_controller.lub:432] Slot found: 7" 3:16:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_deck_bar_controller.lub:446] Dropped middle" 3:16:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:16:08.612 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [deck_utils.lub:52] Adding card to deck slot: 7 cardIndex: 137" 3:16:08.613 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_inventory_controller.lub:497] Card added to deck. Collection index:137" 3:16:08.613 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 137 to deck slot: 7" 3:16:08.613 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:28] [pg_deck_bar_controller.lub:202] Updating cover card" 3:16:11.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:16:11.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_deck_bar_controller.lub:432] Slot found: 8" 3:16:11.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_deck_bar_controller.lub:446] Dropped middle" 3:16:11.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:16:11.456 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [deck_utils.lub:52] Adding card to deck slot: 8 cardIndex: 132" 3:16:11.457 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_inventory_controller.lub:497] Card added to deck. Collection index:132" 3:16:11.457 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 132 to deck slot: 8" 3:16:11.457 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:31] [pg_deck_bar_controller.lub:202] Updating cover card" 3:16:16.815 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:37] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:16:17.549 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:37] [pg_inventory_controller.lub:254] Toggling inventory filter property: Rarity" 3:16:30.862 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:51] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:16:31.988 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:52] [pg_inventory_controller.lub:254] Toggling inventory filter property: Color" 3:16:36.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_deck_bar_controller.lub:428] Dropped card into slot" 3:16:36.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_deck_bar_controller.lub:432] Slot found: 10" 3:16:36.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_deck_bar_controller.lub:446] Dropped middle" 3:16:36.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_deck_bar_controller.lub:316] Got a dragSource with card data" 3:16:36.910 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [deck_utils.lub:52] Adding card to deck slot: 10 cardIndex: 19" 3:16:36.911 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_inventory_controller.lub:497] Card added to deck. Collection index:19" 3:16:36.911 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_deck_bar_controller.lub:693] Added card with collectionindex: 19 to deck slot: 10" 3:16:36.911 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:30:57] [pg_deck_bar_controller.lub:202] Updating cover card" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:169] SectionBrowser:SwitchSection to Marketplace" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:190] SectionBrowser.CloseSectionBeforeSwitch: Closing section \'Forge\'" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:302] DeActivate Deckbuiler" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:117] Reparenting views, ShowPregamSections: 1" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:124] Deckbuilder is ParentView" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:132] ShowPregameSections" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:141] Hiding persistent Views that are not available ingame" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section_browser.lub:204] SectionBrowser.SwitchSection: Opening section \'Marketplace\'" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section.lub:30] PregameSection.Open" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section.lub:37] PregameSection.Open: Setting position on screen" 3:16:59.145 INFO 13764 proxy::logging:72 src="UI (Lua)" message="[00:31:19] [pg_section.lub:41] PregameSection.Open: Initialize controller" 3:16:59.151 DEBUG 9952 from_server::world::WorldMessage_ChangeCharacterLocationStateRMR:9 received msg: 0x4:53 ChangeCharacterLocationStateRMR 3:16:59.151 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:16:59.151 DEBUG 9952 sr_packet::from_game::world::WorldMessage_ChangeCharacterLocationStateRMC:7 sending msg: 0x4:80 ChangeCharacterLocationStateRMC { location: 3, state: 1, map: NotAMap } 3:16:59.163 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:16:59.163 DEBUG 9952 sr_packet::from_game::shop::ShopMessage_GetAllProductsRMC:7 sending msg: 0x3:11 GetAllProductsRMC 3:17:18.356 ERROR 9952 proxy::networking::connect:422 S->P error Io(Os { code: 10054, kind: ConnectionReset, message: "An existing connection was forcibly closed by the remote host." }) 3:17:18.356 INFO 9952 proxy::networking::open_ssl_wrapper:129 disconnecting 3:17:18.358 INFO 9952 proxy::networking::open_ssl_wrapper:144 disconnected 3:17:18.358 DEBUG 9952 proxy::networking::connect:389 sf; target="threading::forge_send_messages_to_server" 3:17:18.358 ERROR 9952 proxy::networking::connect:395 FP->S no msg 3:17:18.359 ERROR 9952 proxy::networking::connect:375 P->BF no msg