Frequently disconnect in game lobby

Age of Empires IV IV - Report a Bug
1

  • Build Number: dr-activerelease1 age4 15.1.6970.0

  • Platform: Steam

  • Operating System: Windows 11

Issue: Frequently disconnect in game lobby

When I play ranked or unranked game, I can see the lobby and all other player, but after random time, it will disconnect and popup a dialog.

After that, match-making will continue (don’t need to click Start button again), and I will join another game soon.

This issue persist but very rare before this DLC update, but it becomes very frequent these days. about 50-80% match must retry 2-3 times, and sometimes I will unable to play with 5min cooldown.

My network is EXTREAMLY well and I never got a single disconnection or lagging during the game, in more than 2 years, ~2000hr game time.

image
image1920×1080 70.6 KB

1 Like
2

another error code here (before join lobby)

eb39d492f15831a9ed462cab11a21076
eb39d492f15831a9ed462cab11a210761008×172 24.5 KB

3

image
image1464×755 206 KB

4
Summary

(I) [00:11:15.821] [000266684]: [PlayFab] PartyStateChangeType::SetTextToSpeechProfileCompleted

(I) [00:11:18.019] [000266684]: WorldwideAutomatch2Service::Process - Waiting, only 0 players ready

(I) [00:11:20.853] [000266684]: Party::OnAutomatch2Event - AET_Polling - R_Success

(I) [00:11:21.020] [000266684]: WorldwideAutomatch2Service::Polling - queued CreateAutomatch2

(I) [00:11:22.036] [000266684]: WorldwideAutomatch2Service::Process - Waiting, only 0 players ready

(I) [00:11:22.069] [000266684]: Party::OnAutomatch2Event - AET_Polling - R_Success

(I) [00:11:24.736] [000266684]: Accepted matchInfo updated 56 from host

(I) [00:11:24.848] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“ItemInstanceMessage”,236993,[[1661910519,14,451762,23925268,1,0,“”,1759581439,0,-1,3,-1]]]

(I) [00:11:24.848] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“ItemInstanceMessage”,236993,[[1661910526,15,452658,23925268,1,0,“”,1759581439,2,-1,19,-1]]]

(I) [00:11:24.848] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“PresenceMessage”,236993,[[15122,20703026,“/steam/76561199654497785”,“{\“sharedHistory\”:1,\“hardwareType\”:0,\“inputDeviceType\”:0}”,“Trafalgar”,“Trafalgar”,“”,8327488,651851,335,2074437,[0,“”,null],“76561199654497785”,3,,1409816,“In Group”,[[1409823,“”]]]]]

(I) [00:11:24.972] [000266684]: Accepted matchInfo updated 59 from host

(I) [00:11:25.253] [000266684]: Accepted matchInfo updated 60 from host

(I) [00:11:25.352] [000266684]: Accepted matchInfo updated 72 from host

(I) [00:11:26.003] [000266684]: WorldwideAutomatch2Service::Process - Waiting, only 0 players ready

(I) [00:11:28.002] [000286084]: MessageCounts: inval=0/0, seek=0/0, join=0/0, ichk=0/0, sk_r=0/0, deny=0/0, Padd=0/2, Pdel=0/0, drop=0/0, data=17/26, mdat=0/0, voip=0/0, rchk=0/0, nudg=4/8, Thdr=0/0, Peer=21/36, PPrx=0/0, ping=0/0, Pfrg=0/0, rely=21/18, lb_p=10/3, lb_c=0/0, cast=0/0, cdat=0/0, sorq1=0/0, sorp=0/0, acto=0/0, spob=0/0, sorq2=0/0, setp=0/0, actr=0/0, lsim=0/0, rlbc=0/0, rlbc2=0/0, endg=0/0

(I) [00:11:30.003] [000266684]: WorldwideAutomatch2Service::Process - Waiting, only 0 players ready

(I) [00:11:32.036] [000266684]: WorldwideAutomatch2Service::Polling - queued CreateAutomatch2

(I) [00:11:32.253] [000266684]: Accepted matchInfo updated 73 from host

(I) [00:11:32.695] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“ItemInstanceMessage”,236993,[[1619564507,8,6005067,11401583,1,0,“”,1748936447,0,-1,35,-1]]]

(I) [00:11:32.695] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“ItemInstanceMessage”,236993,[[1673369653,3,6005150,11401583,1,0,“”,1762320276,2,-1,51,-1]]]

(I) [00:11:32.738] [000266684]: Accepted matchInfo updated 74 from host

(I) [00:11:33.102] [000266684]: Accepted matchInfo updated 76 from host

(I) [00:11:33.920] [000266684]: Party::OnAutomatch2Event - AET_Polling - R_Success

(I) [00:11:34.003] [000266684]: WorldwideAutomatch2Service::Process - Waiting, only 0 players ready

(I) [00:11:34.854] [000266684]: Accepted matchInfo updated 77 from host

(I) [00:11:35.255] [000266684]: Accepted matchInfo updated 78 from host

(I) [00:11:38.004] [000266684]: WorldwideAutomatch2Service::Process - Waiting, only 0 players ready

(I) [00:11:40.002] [000266684]: [Match Flow] MatchSetup::StartMatch() - m_matchStatus = ST_STARTING

(I) [00:11:40.688] [000266684]: UI Async loading data:ui\loading\pages\loadmultiplayerpage.xaml

(I) [00:11:40.694] [000266684]: Movie Manager – No movies with locale [zh-Hans] exist on disk. Switching to fallback locale [en].

(I) [00:11:40.713] [000266684]: Movie Manager – No movies with locale [zh-Hans] exist on disk. Switching to fallback locale [en].

(I) [00:11:40.749] [000266684]: Party::SetStatus - S_PLAYING

(I) [00:11:40.796] [000266684]: Sending matchinfo change #21

(I) [00:11:40.796] [000266684]: Accepted matchInfo updated 79 from host

(E) [00:11:40.892] [000266684]: Rejecting packet type 0 that claims to come from ourself

(I) [00:11:41.620] [000266684]: Accepted matchInfo updated 80 from host

(I) [00:11:42.037] [000266684]: WorldwideAutomatch2Service::Process - Got into game successfully, 8 players present, got correct slot settings - readying up

(I) [00:11:42.038] [000266684]: WorldwidePartyService::RequestReady: Sending PlayerReadyRequest; profileID=236993 isReady=1 isSuccessful=1

(I) [00:11:42.236] [000266684]: Accepted matchInfo updated 81 from host

(I) [00:11:42.469] [000266684]: Accepted matchInfo updated 82 from host

(I) [00:11:42.973] [000266684]: Accepted matchInfo updated 83 from host

(I) [00:11:43.021] [000266684]: WorldwideAutomatch2Service::Polling - queued CreateAutomatch2

(I) [00:11:43.120] [000266684]: Accepted matchInfo updated 84 from host

(I) [00:11:43.220] [000266684]: Accepted matchInfo updated 85 from host

(I) [00:11:43.621] [000266684]: Accepted matchInfo updated 86 from host

(I) [00:11:43.631] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“ItemInstanceMessage”,236993,[[1593614200,156,454687,22429078,1,0,“”,1742732405,0,-1,35,-1]]]

(I) [00:11:43.631] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“ItemInstanceMessage”,236993,[[1673620164,1,6005145,22429078,1,0,“”,1762355543,2,-1,51,-1]]]

(I) [00:11:43.709] [000266684]: Accepted matchInfo updated 87 from host

(I) [00:11:43.756] [000266684]: SessionID : c2a48d0 - Disconnect called with reasonID 127 - WorldwideAutomatch2Service::ValidateCurrentMatch - delivered another match:204097936. already in 204097744

(I) [00:11:43.756] [000266684]: Automatch2Internal - Server told us to host matchID [204097936]

(E) [00:11:43.756] [000266684]: WorldwideAutomatch2Service::OnHost - in the middle of a disconnect, ignoring

(I) [00:11:43.756] [000266684]: Party::OnAutomatch2Event - AET_Polling - R_Success

(I) [00:11:43.804] [000266684]: SteamLobbyList::RemoveLobby: Removed Steam lobby; lobbyId=109775241017846991 sessionId=204097744

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_HOSTMIGRATION

(I) [00:11:43.873] [000266684]: WorldwidePartyService::OnHostMigration - [204097744] Got a queued migration event while disconnecting, ignoring

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 1

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=23834906, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 2

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=23925268, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 3

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=11401583, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 4

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=4668626, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 5

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=19671473, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 6

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=14300876, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 8

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=22429078, reasonID=120, reason debug hint - Forcing peers to disconnect

(I) [00:11:43.873] [000266684]: WorldwideAdvertisementService::Process - EVENT_DESTROYPEER

(I) [00:11:43.873] [000266684]: WorldwidePartyService::PeerRemove, Removing peer ID: 7

(I) [00:11:43.873] [000266684]: peerremove - peerIDRemoved=236993, reasonID=127, reason debug hint - WorldwideAutomatch2Service::ValidateCurrentMatch - delivered another match:204097936. already in 204097744

(I) [00:11:43.893] [000266684]: [Match Flow] Remove local player. Reason (3)

(I) [00:11:43.912] [000266684]: [Match Flow] Local player was removed during the Starting or Loading phase. Returning to the FE

(I) [00:11:43.912] [000266684]: MatchSetupManager::RequestLeaveGameMatch - DestroyCurrentMatch()

(E) [00:11:43.912] [000266684]: LeaveSimulation called while !IsConnected

(I) [00:11:43.912] [000266684]: SessionID : c2a48d0 - Disconnect called with reasonID 1000 - Relic::Game::MatchSetup::Destroy> m_matchStatus : 5 >> MatchSetup::Disconnect >

(I) [00:11:43.912] [000266684]: [Match Flow] Local player was removed during the Connecting or Configuring phase. Invalidating match status.

(E) [00:11:43.913] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:43.913] [000266684]: SessionID : c2a48d0 - Disconnect called with reasonID 1000 - Relic::Game::MatchSetup::~MatchSetup> MatchSetup::Disconnect >

(E) [00:11:43.924] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:43.935] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:43.945] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:43.956] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:43.956] [000266684]: UI Async loading data:ui\Lobby\Widgets\TaskBarWidget.xaml

(I) [00:11:43.956] [000266684]: UI Async loading data:ui\lobby\widgets\notificationwidget.xaml

(I) [00:11:43.956] [000266684]: UI Async loading data:ui\Lobby\Pages\FEBackgroundPage.xaml

(I) [00:11:43.956] [000266684]: UI Async loading data:ui\shared\modalpages\UserPromptModalPage.xaml

(I) [00:11:43.958] [000266684]: UI Async loading data:ui\shared\modalpages\UserPromptModalPage.xaml

(I) [00:11:43.962] [000266684]: Disconnect process already running

(I) [00:11:43.962] [000266684]: Disconnect process already running

(I) [00:11:43.962] [000266684]: Party::SetStatus - S_CONFIGURING

(I) [00:11:43.962] [000266684]: UI Async loading data:ui\lobby\SemiModalPages\AutoMatchLobbySemiModalPage.xaml

(I) [00:11:43.965] [000266684]: Movie Manager – No movies with locale [zh-Hans] exist on disk. Switching to fallback locale [en].

(E) [00:11:43.966] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:43.977] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:43.987] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:43.998] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:44.005] [000266684]: Sending matchinfo change #22

(I) [00:11:44.005] [000266684]: UI Async loading data:ui\Lobby\Pages\MultiplayerPage.xaml

(E) [00:11:44.009] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:44.010] [000266684]: Movie Manager – No movies with locale [zh-Hans] exist on disk. Switching to fallback locale [en].

(E) [00:11:44.020] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.030] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.040] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.050] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.061] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.071] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.082] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:44.090] [000266684]: Movie Manager – No movies with locale [zh-Hans] exist on disk. Switching to fallback locale [en].

(E) [00:11:44.092] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.102] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.114] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.124] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.135] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:44.139] [000266684]: UI Async loading data:ui\Lobby\Pages\MultiplayerPageCasualPane.xaml

(E) [00:11:44.145] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.156] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.158] [000266684]: Rejecting packet type 0 that claims to come from ourself

(I) [00:11:44.161] [000266684]: UI Async loading data:ui\Lobby\Pages\MultiplayerPageRankedPane.xaml

(E) [00:11:44.166] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.176] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.187] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.198] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.208] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.219] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.229] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.240] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.250] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.261] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.272] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.282] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.292] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.303] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.313] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.324] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.334] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(E) [00:11:44.345] [000286084]: Session::SendQueuedMessagesToRelay local peer is missing, not sending

(I) [00:11:44.350] [000266684]: PeerRemoveAll - flushing local session peer data

(I) [00:11:44.350] [000266684]: LeaveSessionInternal - no action taken, needLeave=0, service=0

(I) [00:11:44.350] [000266684]: Destroyed Matchinfo for sessionID 204097744

(E) [00:11:44.350] [000266684]: Socks::free: Socket 0/784 did not close properly before being freed.

(I) [00:11:44.350] [000266684]: OnDestroyPartyNotification - partyID = 204097744, prevID = -1

(I) [00:11:44.350] [000266684]: OnDestroyPartyNotification - partyID = 204097744, prevID = 204097727

(E) [00:11:44.398] [000266684]: SteamLobbyList::RemoveLobby: Attempt to remove nonexistent lobby; sessionId=204097744

(I) [00:11:44.839] [000284032]: WebSocketConnection::ProcessMessages: message=[0,“Automatch2StopPollingMessage”,236993,[236993,0]]

(I) [00:11:44.853] [000266684]: WorldwideAutomatch2Service::OnPollComplete - automatch process complete with result = 2

(I) [00:11:44.903] [000266684]: Sending matchinfo change #23

(E) [00:11:45.020] [000266684]: Rejecting packet type 0 that claims to come from ourself

5

unplayable for many days

6

It looks like I have joined to multiple lobby at same time.

The match making process seems not end after successful make a match.