Steam with Servertravel - Seamless travel issue - FULL BP

anonymous_user_792edd99 · November 30, 2015, 4:58pm

Hi !

I’m trying to move all my clients in a new map from lobby map.
Join session works fine, client can connect to my server and join lobby map.

‘Go Button’ Execute this line : ServerTravel Level, and bellow result :

w/o SeamLess travel, only host travel and client stay in lobby.
With Seamless nobody travel

I’m trying this with two friends on different steam accounts .

Here is my engine.ini

and here my log w/o seamless travel, SyLiz is my testing friend, he can connect to lobby but when server ask for travel he can’t join map. i have updated log, we have more usefull information. Even if i don’t know what’s happen here

 [2015.11.30-16.13.14:932][507]LogNet: Login request: /Game/2DSideScrollerBP/Maps/MenuAccueil?Name=SyLiz userId: 76561197967599662
[2015.11.30-16.13.14:997][511]LogNet: Client netspeed is 10000
[2015.11.30-16.13.15:029][513]LogNet: Join request: /Game/2DSideScrollerBP/Maps/MenuAccueil?Name=SyLiz?SplitscreenCount=1
[2015.11.30-16.13.15:031][513]LogGameMode: Warning - PATHS NOT DEFINED or NO PLAYERSTART with positive rating
[2015.11.30-16.13.15:036][513]LogNet: Join succeeded: SyLiz
[2015.11.30-16.13.20:423][832]LogPackageName: SearchForPackageOnDisk took   0.247s to resolve Level.
[2015.11.30-16.13.20:424][832]LogGameMode: ProcessServerTravel: /Game/2DSideScrollerBP/Maps/Level
[2015.11.30-16.13.23:377][ 16]LogNet: UChannel::ReceivedSequencedBunch: Bunch.bClose == true. ChIndex == 0. Calling ConditionalCleanUp.
[2015.11.30-16.13.23:377][ 16]LogNet: UChannel::CleanUp: [GameNetDriver] [MyController_C_2] [MyController_C_2]. ChIndex == 0. Closing connection.
[2015.11.30-16.13.23:378][ 16]LogNet: UNetConnection::Close: Name: SteamNetConnection_0, Driver: GameNetDriver SteamNetDriver_0, PC: MyController_C_2, Owner: MyController_C_2, Channels: 8, RemoteAddr: 76561197967599662:7777, Time: 2015.11.30-16.13.23
[2015.11.30-16.13.23:378][ 16]LogNet: UChannel::Close: Sending CloseBunch. ChIndex == 0. Name: ControlChannel_0
[2015.11.30-16.13.24:168][ 65]LogEngine: Server switch level: /Game/2DSideScrollerBP/Maps/Level
[2015.11.30-16.13.24:168][ 65]LogNet: Browse: /Game/2DSideScrollerBP/Maps/Level?listen
[2015.11.30-16.13.24:168][ 65]LogLoad: LoadMap: /Game/2DSideScrollerBP/Maps/Level?listen
[2015.11.30-16.13.24:168][ 65]LogNet: World NetDriver shutdown SteamNetDriver_0 [GameNetDriver]
[2015.11.30-16.13.24:168][ 65]LogNet: DestroyNamedNetDriver SteamNetDriver_0 [GameNetDriver]
[2015.11.30-16.13.24:168][ 65]LogExit: GameNetDriver SteamNetDriver_0 shut down
[2015.11.30-16.13.24:178][ 65]LogParticles: Destroying 0 GPU particle simulations for FXSystem 0x00000000114E2080
[2015.11.30-16.13.24:185][ 65]LogMemory: Platform Memory Stats for WindowsNoEditor
[2015.11.30-16.13.24:185][ 65]LogMemory: Process Physical Memory: 297.03 MB used, 304.81 MB peak
[2015.11.30-16.13.24:185][ 65]LogMemory: Process Virtual Memory: 288.79 MB used, 298.42 MB peak
[2015.11.30-16.13.24:185][ 65]LogMemory: Physical Memory: 7991.72 MB used, 8154.24 MB total
[2015.11.30-16.13.24:185][ 65]LogMemory: Virtual Memory: 723.65 MB used, 8388608.00 MB total
[2015.11.30-16.13.24:185][ 65]LogMemory: 
[2015.11.30-16.13.24:186][ 65]LogMemory: Allocator Stats for binned:
[2015.11.30-16.13.24:186][ 65]LogMemory: Current Memory 107.79 MB used, plus 11.12 MB waste
[2015.11.30-16.13.24:186][ 65]LogMemory: Peak Memory 125.88 MB used, plus 2.63 MB waste
[2015.11.30-16.13.24:186][ 65]LogMemory: Current OS Memory 118.91 MB, peak 128.51 MB
[2015.11.30-16.13.24:186][ 65]LogMemory: Current Waste 1.17 MB, peak 1.20 MB
[2015.11.30-16.13.24:186][ 65]LogMemory: Current Used 107.80 MB, peak 125.88 MB
[2015.11.30-16.13.24:186][ 65]LogMemory: Current Slack 9.95 MB
[2015.11.30-16.13.24:186][ 65]LogMemory: Allocs       190101 Current /  4728792 Total
[2015.11.30-16.13.24:186][ 65]LogMemory: 
[2015.11.30-16.13.24:186][ 65]LogMemory: Block Size Num Pools Max Pools Cur Allocs Total Allocs Min Req Max Req Mem Used Mem Slack Mem Waste Efficiency
[2015.11.30-16.13.24:186][ 65]LogMemory: ---------- --------- --------- ---------- ------------ ------- ------- -------- --------- --------- ----------
[2015.11.30-16.13.24:186][ 65]LogMemory:          8         0         0          0            0       8       0       0K        0K        0K    100.00%
[2015.11.30-16.13.24:186][ 65]LogMemory:         16         7         7      22458       980534      16      16     350K       98K        0K    100.00%
[2015.11.30-16.13.24:186][ 65]LogMemory:         32        20        20      39933       368138      17      32    1247K       33K      151K     88.20%
[2015.11.30-16.13.24:186][ 65]LogMemory:         48        14        14      14486       295008      33      48     679K      217K       87K     90.29%
[2015.11.30-16.13.24:186][ 65]LogMemory:         64        26        26      24220       416817      49      64    1513K      151K      175K     89.48%
[2015.11.30-16.13.24:186][ 65]LogMemory:         80        16        16      11163       215924      65      80     872K      152K       66K     93.55%
[2015.11.30-16.13.24:186][ 65]LogMemory:         96         9         9       5287       269729      81      96     495K       81K       39K     93.23%
[2015.11.30-16.13.24:186][ 65]LogMemory:        112         7         7       3415       248583      97     112     373K       75K       12K     97.32%
[2015.11.30-16.13.24:186][ 65]LogMemory:        128        51        51      25673       188510     114     128    3209K       55K      146K     95.53%
[2015.11.30-16.13.24:186][ 65]LogMemory:        160        17        17       6527       416544     129     160    1019K       68K       92K     91.54%
[2015.11.30-16.13.24:186][ 65]LogMemory:        192        32        32       9402       311632     161     192    1762K      284K      166K     91.89%
[2015.11.30-16.13.24:186][ 65]LogMemory:        224        23        34       6390       366469     193     224    1397K       73K      104K     92.93%
[2015.11.30-16.13.24:186][ 65]LogMemory:        256        12        12       2694       225769     225     256     673K       95K       29K     96.22%
[2015.11.30-16.13.24:186][ 65]LogMemory:        288         8        11       1523        51576     257     288     428K       83K       21K     95.90%
[2015.11.30-16.13.24:186][ 65]LogMemory:        320         8         9       1144        31521     289     320     357K      153K       15K     97.07%
[2015.11.30-16.13.24:186][ 65]LogMemory:        384        25        25       3552        57382     322     384    1332K      262K      110K     93.13%
[2015.11.30-16.13.24:186][ 65]LogMemory:        448        16        16       2108        40809     385     448     922K      100K       43K     95.80%
[2015.11.30-16.13.24:186][ 65]LogMemory:        512        13        13       1519        18406     449     512     759K       73K       55K     93.39%
[2015.11.30-16.13.24:186][ 65]LogMemory:        576        18        18       1464        10988     513     576     823K      322K       55K     95.23%
[2015.11.30-16.13.24:186][ 65]LogMemory:        640        21        21       1381         3317     577     640     863K      476K       52K     96.13%
[2015.11.30-16.13.24:186][ 65]LogMemory:        704        23        23       1479         3329     641     704    1016K      455K       52K     96.47%
[2015.11.30-16.13.24:186][ 65]LogMemory:        768        11        11        546         7924     705     768     409K      293K       15K     97.87%
[2015.11.30-16.13.24:186][ 65]LogMemory:        896         6         6        311        42130     769     896     272K      112K       27K     92.97%
[2015.11.30-16.13.24:186][ 65]LogMemory:       1024         5         5        234        26549     897    1024     234K       86K        7K     97.81%
[2015.11.30-16.13.24:186][ 65]LogMemory:       1168         6         6        238         2096    1025    1168     271K      113K       15K     96.09%
[2015.11.30-16.13.24:186][ 65]LogMemory:       1360        21        23        386        14096    1172    1360     512K      827K       43K     96.80%
[2015.11.30-16.13.24:186][ 65]LogMemory:       1632        15        15        473         5949    1361    1632     753K      204K       44K     95.42%
[2015.11.30-16.13.24:186][ 65]LogMemory:       2048        28        34        293        19673    1633    2048     586K     1206K       41K     97.71%
[2015.11.30-16.13.24:186][ 65]LogMemory:       2336        13        13        204         4620    2050    2336     465K      366K       49K     94.11%
[2015.11.30-16.13.24:186][ 65]LogMemory:       2720        13        13        201         1101    2337    2717     533K      296K       33K     96.03%
[2015.11.30-16.13.24:186][ 65]LogMemory:       3264        22        22        259         9843    2721    3264     825K      578K       82K     94.18%
[2015.11.30-16.13.24:186][ 65]LogMemory:       4096        24        27        250         1413    3265    4096    1000K      536K       94K     93.88%
[2015.11.30-16.13.24:186][ 65]LogMemory:       4672        15        17        138         4844    4104    4666     629K      330K       31K     96.77%
[2015.11.30-16.13.24:186][ 65]LogMemory:       5456        15        19        119         1484    4673    5456     634K      326K       58K     93.96%
[2015.11.30-16.13.24:186][ 65]LogMemory:       6544        18        19        133         1698    5465    6537     849K      302K       93K     91.93%
[2015.11.30-16.13.24:186][ 65]LogMemory:       8192        12        13         66         3721    6552    8192     528K      240K       86K     88.80%
[2015.11.30-16.13.24:186][ 65]LogMemory:       9360         8         9         40          162    8200    9360     365K      147K       20K     96.09%
[2015.11.30-16.13.24:186][ 65]LogMemory:      10912         7         9         28         4251    9383   10911     298K      150K       18K     95.98%
[2015.11.30-16.13.24:186][ 65]LogMemory:      13104         8        15         34        37000   10976   13056     435K       77K       36K     92.97%
[2015.11.30-16.13.24:186][ 65]LogMemory:      16384        15        15         47         2584   13112   16384     752K      208K       15K     98.44%
[2015.11.30-16.13.24:186][ 65]LogMemory:      21840        24        31         51         1096   16400   21824    1087K      449K      159K     89.65%
[2015.11.30-16.13.24:186][ 65]LogMemory:      32768        10        19         18          131   21865   32640     576K       64K      128K     80.00%
[2015.11.30-16.13.24:186][ 65]LogMemory: 
[2015.11.30-16.13.24:186][ 65]LogMemory: 42368K allocated in pools (with 10216K slack and 2564K waste). Efficiency 93.95%
[2015.11.30-16.13.24:186][ 65]LogMemory: Allocations 189888 Current / 4713351 Total (in 662 pools)
[2015.11.30-16.13.24:186][ 65]LogMemory: 
[2015.11.30-16.13.24:207][ 65]LogLinker:Warning: CreateImport: Failed to load Outer for resource 'WidgetTree': WidgetBlueprint /Script/UMGEditor.Default__WidgetBlueprint
[2015.11.30-16.13.24:324][ 65]LogAIModule: Creating AISystem for world Level
[2015.11.30-16.13.24:324][ 65]LogWorld: Game class is '2DSideScrollerGameMode_C'
[2015.11.30-16.13.24:324][ 65]LogNet:Display: SteamNetDriver_1 bound to port 7777
[2015.11.30-16.13.24:324][ 65]LogNet: GameNetDriver SteamNetDriver_1 IpNetDriver listening on port 7777
[2015.11.30-16.13.24:340][ 65]LogWorld: Bringing World /Game/2DSideScrollerBP/Maps/Level.Level up for play (max tick rate 0) at 2015.11.30-17.13.24
[2015.11.30-16.13.24:350][ 65]LogWorld: Bringing up level for play took: 0.024601
[2015.11.30-16.13.24:352][ 65]LogOnline:Warning: STEAM: Can't start an online session (Game) in state InProgress
[2015.11.30-16.13.24:361][ 66]LogBlueprintUserMessages: [GenericCharacter_C_3] Loaded in :0.0
[2015.11.30-16.13.24:397][ 66]LogBlueprintUserMessages: [GenericCharacter_C_3] RDY TO PLAY
[2015.11.30-16.13.30:953][473]LogNet: NotifyAcceptingConnection: Server Level accept
[2015.11.30-16.13.30:953][473]LogNet: Open Level 11/30/15 17:13:30 76561197967599662
[2015.11.30-16.13.30:953][473]LogNet: Added client connection.  Remote address = 76561197967599662:7777
[2015.11.30-16.13.30:953][473]LogNetTraffic:Warning: High single frame packet loss: 14
[2015.11.30-16.13.30:953][473]LogNet: NotifyAcceptingChannel Control 0 server World /Game/2DSideScrollerBP/Maps/Level.Level: Accepted
[2015.11.30-16.13.30:953][473]LogNet: Remote platform little endian=1
[2015.11.30-16.13.30:953][473]LogNet: This platform little endian=1
[2015.11.30-16.13.30:953][473]LogNet: GetLocalNetworkVersion: GEngineNetVersion: 2758231, ProjectName: sorcererthingv1, ProjectVersion: 1.0.0.0, InternalProtocolVersion: 9, LocalNetworkVersion: 1456003609
[2015.11.30-16.13.31:017][477]LogNet: Login request: /Game/2DSideScrollerBP/Maps/Level?game=/Game/2DSideScrollerBP/Blueprints/2DSideScrollerGameMode.2DSideScrollerGameMode_C?Name=SyLiz userId: 76561197967599662
[2015.11.30-16.14.04:627][554]LogNet: Client netspeed is 10000
[2015.11.30-16.14.04:627][554]LogNet: UChannel::ReceivedSequencedBunch: Bunch.bClose == true. ChIndex == 0. Calling ConditionalCleanUp.
[2015.11.30-16.14.04:627][554]LogNet: UChannel::CleanUp: [GameNetDriver] [NoPC] [No Owner]. ChIndex == 0. Closing connection.
[2015.11.30-16.14.04:627][554]LogNet: UNetConnection::Close: Name: SteamNetConnection_1, Driver: GameNetDriver SteamNetDriver_1, PC: NULL, Owner: NULL, Channels: 2, RemoteAddr: 76561197967599662:7777, Time: 2015.11.30-16.14.04
[2015.11.30-16.14.04:627][554]LogNet: UChannel::Close: Sending CloseBunch. ChIndex == 0. Name: ControlChannel_1
[2015.11.30-16.16.08:780][139]LogEngine: All Windows Closed
[2015.11.30-16.16.08:780][139]LogWindows: FPlatformMisc::RequestExit(0)
[2015.11.30-16.16.08:958][140]LogNet: World NetDriver shutdown SteamNetDriver_1 [GameNetDriver]
[2015.11.30-16.16.08:958][140]LogNet: DestroyNamedNetDriver SteamNetDriver_1 [GameNetDriver]
[2015.11.30-16.16.08:958][140]LogExit: GameNetDriver SteamNetDriver_1 shut down
[2015.11.30-16.16.09:048][140]LogExit: Preparing to exit.
[2015.11.30-16.16.09:098][140]LogExit: Game engine shut down

anonymous_user_33800a51 · December 1, 2015, 11:55pm

Hey RomFou,

Please and attach Server and Client logs for a session in which Seamless Travel is enabled and travel fails. log you pasted here shows a successful travel, so it’s not terribly helpful.

Are you using same GameMode for both lobby and map you’re traveling to? If not, is Seamless Travel enabled in both GameModes? Are you using a Transition Map? If so, is it using a default GameMode that also has Seamless Travel enabled? Are you able to reproduce this behavior in a new project as well? Can you show me an image of your Blueprint layout for traveling?

If you’re able to put a small test project together for me to look over, that would be tremendously helpful. I know there have been some problems with ServerTravel, and Seamless Travel was disabled for a while (I’m actually surprised to see it in 4.10 at all). If you can make that test project (or share you full project, if you can’t repro in a smaller project), please and upload it somewhere like Google Drive or Dropbox and send me a link. You can do so privately if you need to, via PM on forums:

Thanks!

anonymous_user_792edd99 · December 2, 2015, 2:53am

Hello !

i’m using same GameMode for both map and no transition map yet !

i will make this first and in same time this little project to see more clearly about this problem ( if i can reproduce error as you said )

Thanks you for your help

anonymous_user_792edd99 · December 2, 2015, 6:27pm

Okay i have server log and client log with seamless travel On.

i tried to figure why nobody travel but i didn’t find.

I finished repro project and seamless travel works fine! So i re check my project option and i discovered this : “Global default server gamemode” with this new setting server can travel now, i didn’t test with client yet. But my controller don’t change with travel, it’s same on both map, is that normal ? If yes i just have to test this with a distant client to se if he can travel too .

So one more time it’s my fault, maybe i have to put my thread in BP scripting first.

I will add a new comment after client test to be sure about this

69060-logsseamlesstravel.rar (25.3 KB)

anonymous_user_33800a51 · December 2, 2015, 6:50pm

Looking through Client log, i see Client is disconnected directly after Seamless Travel completes. So Client is making it to new map, but then Host closes connection. Looking at Host log, I’m seeing a LOT of “Too many calls to RPC” warnings, meaning that you’re performing so many RPCs in new map that Client is automatically disconnected to avoid connection issues.

I’d take a look at those warnings in Host log and find each of RPC calls in your project and remove any unnecessary calls, and make sure most aren’t marked as Reliable. I don’t know if this will fix issue for you, however. Server Travel without Seamless Travel should work as well, but you mention that it does not.

Let me know what happens with test project when you get time. Thanks!

anonymous_user_792edd99 · December 5, 2015, 6:24pm

Hi !

So, Seamless Travel works fine now ! RPC spam is fixed, but Controller don’t reload after travel. not a big deal, i just have to change some logic in my controller. In conclusion seamless work fine for me

With out seamless travel only server can travel across maps.
Here is log w/o seamless

I’m sorry but i don’t have time this week, i will finish my project test tomorrow for sure and see what’s happen w/o seamless travel.

We have this line in both client and server log. → 76561197967599662:7777: Invalid_Data: Received a packet with an Acked PacketID

link text

anonymous_user_33800a51 · December 7, 2015, 6:11pm

Okay, cool, I’m glad that got it working for you.

Let me know if you get an example project with Server Travel not taking Clients along with it. Regardless of whether Seamless Travel is enabled, Server should take all Clients with it if Server calls travel. I’m guessing you’re calling this on Clients instead, or as well, and it’s causing a problem, but that’s just a guess.

If you decide it’s not an issue now that you have Seamless Travel working, that’s fine too. I’ll mark this post Resolved for now, but let me know if you need to keep investigating non-seamless travel issue. Thanks!

anonymous_user_792edd99 · December 7, 2015, 6:48pm

Hey ! So, my project test is here Project TEST . But When i’m testing it with a friend on steam, seamless and noseamless failed…
whereas it works on my game project .I have logs (server/client) for each case.

When i’m testing it on my comp with local client and -nosteam option it’s works fine both seamless and no seamless.

Hard time with steam :/, i read something here about same problem : Steam Servertravel in BP (4.10) Server is not taking clients - Platform & Builds - Epic Developer Community Forums .

link text

anonymous_user_33800a51 · December 8, 2015, 6:43pm

Hey RomFou,

I’d need to see project, not packaged game.

Looking at logs, I see some references to a port error. I’m wondering if your Client system is running behind a firewall. Can you test on a different system that you know isn’t behind a firewall?

anonymous_user_792edd99 · December 8, 2015, 11:48pm

■■■■, of course you need project, sorry ! I upload it and update link.

Friends don’t have particular firewall, only windows firewall. Do we have to forward port ?

Is that line say you something ? : Invalid_Data: Received a packet with an Acked PacketID

I will test with windows firewall OFF both side (client / server )

anonymous_user_33800a51 · December 10, 2015, 5:53pm

Okay, let me know when you have project up somewhere and what new link is. Also let me know results of your firewall test is.

packet error doesn’t seem to be problem. Let’s double check firewall problem first.

You may need to specify ports, which you would do in project’s DefaultEngine.ini file.

anonymous_user_792edd99 · December 14, 2015, 3:09pm

Sorry for time, i’m in holliday ! Here is link for project test link.

I still need to test w/o port and firewall. I come back with these result.