Fluid pipe has performance issues

Question

Fluid pipe has performance issues

Nallars opened this issue 5 years ago · 9 comments

Nallars commented 5 years ago

Please complete the following information:

Forge Version: 14.23.5.2838
BuildCraft Version : 7.99.24.1
Any additonal mods: Some mods like Thermal Expansion, EnderIO ect...

To Reproduce
Steps to reproduce the behavior:

Launch Server (solo ?)
Wait
Show all entities (I do that with TickProfiler)

So, the issue is that when I monitor the evolution of TileEntity in my server, the number TilePipeHolder is growing quickly.

When I reboot the great majority of them disapear, but they still comme back.

For example, when I reboot the server, I have like 5000 TilePipeHolder, but after a day running, it can grow up to 70000. It may cause the TPS decrease in my server. A reboot fixes this.

Any guess why / is it a normal behavior ?

AlexIIL · Answer 1 · 2019-08-13T20:47:55.000Z

That sounds like normal chunk loading - assuming you actually have 500 to 70,000 pipes in your world. (Essentially is that the number of pipe blocks - in total - in your server's worlds?)

Nallars · Answer 2 · 2019-08-13T21:39:58.000Z

No we probably have a ~3000 pipes maybe a little more... Clearly I don't think we have 70,000! (I'll make sure of that tomorrow, but that's seems unlikely) Even if we had so many, why the number gradually increase even if nobody is connected (so nobody add any pipes)? And then go back to a normal number after a reboot? Then reincrease ect...?

I'm not aware of how modded minecraft (nor minecraft) handle entities but TilePipeHolder is the only one with this behavior as far as I can see with TickProfiler

AlexIIL · Answer 3 · 2019-08-13T22:38:27.000Z

Ok, in that case it definitely sounds like a bug. Can you try updating to 7.99.24.2 to see if I've (accidentally) fixed it in that version?

Nallars · Answer 4 · 2019-08-14T09:31:44.000Z

I can't update Buildcraft for now, will do soon (probably tonight or tomorrow). But I did investigate a little more on this issue.

Using TickProfiler and LagGoggles I was able to understand a little bit more TickProfiler. So I think the "70,000" number, isn't the number of pipes but the usage in µS/tick.

I didn't reboot the server since yesterday and I came to this results:

[TickProfiler]: 
          Class | Count
     EntityItem |   164
EntityButterfly |   100
    EntitySheep |    33
 EntitySkeleton |    27
EntityPigZombie |    25
      EntityCow |    24
  EntityCreeper |    19
EntityItemFrame |    16
   EntityZombie |    14
      EntityPig |    13
                Class | Count
       TilePipeHolder | 60910 <--- This number is growing constantly (I never saw it stop growing so I don't know how big it an goes) (go back to like ~5000 or so after a reboot, iirc)
TileSmelteryComponent |  4345
           TileLeaves |  2491
               Opaque |  1044
    TileConduitBundle |   788
         TileCableBus |   536
           Reinforced |   331
               Opaque |   326
      TileEntityChest |   263
      TileEntityMulti |   218

Using LagGoggles, I'm able to tell you that we have 554 Pipes (guess I was wrong with those 3000 pipes :') )

But the problem is that they are using many µs/t as you can see here :

Logs :

[09:47:47] [DedicatedServer]: 25108 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TileMultipart_cmp$$0, BLOCK_POS_X=-52, BLOCK_POS_Y=67, BLOCK_POS_Z=288, BLOCK_CLASS_NAME=TileMultipart_cmp$$0, NANOS=1280516978}
[09:47:47] [DedicatedServer]: 4423 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=Smeltery, BLOCK_POS_X=-62, BLOCK_POS_Y=65, BLOCK_POS_Z=289, BLOCK_CLASS_NAME=slimeknights.tconstruct.smeltery.tileentity.TileSmeltery, NANOS=225578141}
[09:47:47] [DedicatedServer]: 2541 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=Item Hopper, BLOCK_POS_X=130, BLOCK_POS_Y=56, BLOCK_POS_Z=213, BLOCK_CLASS_NAME=pl.asie.foamfix.common.TileEntityFasterHopper, NANOS=129611004}
[09:47:47] [DedicatedServer]: 1717 micro-s/t: TILE_ENTITY: {WORLD_ID=-1, BLOCK_NAME=TilePump, BLOCK_POS_X=-18, BLOCK_POS_Y=79, BLOCK_POS_Z=-17, BLOCK_CLASS_NAME=buildcraft.factory.tile.TilePump, NANOS=87575271}
[09:47:47] [DedicatedServer]: 1562 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=Smeltery, BLOCK_POS_X=-50, BLOCK_POS_Y=65, BLOCK_POS_Z=289, BLOCK_CLASS_NAME=slimeknights.tconstruct.smeltery.tileentity.TileSmeltery, NANOS=79678656}
[09:47:47] [DedicatedServer]: 1032 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=151, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=52657052}
[09:47:47] [DedicatedServer]: 998 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=157, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=50915567}
[09:47:47] [DedicatedServer]: 913 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=49, BLOCK_POS_Z=157, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=46569776}
[09:47:47] [DedicatedServer]: 902 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=141, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=46020974}
[09:47:47] [DedicatedServer]: 898 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=123, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=45819250}
[09:47:47] [DedicatedServer]: 889 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=129, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=45346045}
[09:47:47] [DedicatedServer]: 883 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=50, BLOCK_POS_Z=158, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=45038247}
[09:47:47] [DedicatedServer]: 871 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=111, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=44423674}
[09:47:47] [DedicatedServer]: 857 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=152, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=43733427}
[09:47:47] [DedicatedServer]: 839 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=156, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=42826354}
[09:47:47] [DedicatedServer]: 826 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=144, BLOCK_POS_Y=55, BLOCK_POS_Z=212, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=42166619}
[09:47:47] [DedicatedServer]: 826 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=145, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=42141409}
[09:47:47] [DedicatedServer]: 816 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=134, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=41632643}
[09:47:47] [DedicatedServer]: 811 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=153, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=41381567}
[09:47:47] [DedicatedServer]: 789 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=144, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=40273508}
[09:47:47] [DedicatedServer]: 776 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=49, BLOCK_POS_Z=155, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=39595230}
[09:47:47] [DedicatedServer]: 757 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=135, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=38649885}
[09:47:47] [DedicatedServer]: 753 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=51, BLOCK_POS_Z=159, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=38431857}
[09:47:47] [DedicatedServer]: 750 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=155, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=38281080}
[09:47:47] [DedicatedServer]: 740 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=132, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=37741403}
[09:47:47] [DedicatedServer]: 737 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=126, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=37588518}
[09:47:47] [DedicatedServer]: 727 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=133, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=37081253}
[09:47:47] [DedicatedServer]: 705 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=147, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=35997077}
[09:47:47] [DedicatedServer]: 705 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=142, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=35963005}
[09:47:47] [DedicatedServer]: 697 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TileQuarry, BLOCK_POS_X=147, BLOCK_POS_Y=63, BLOCK_POS_Z=-1271, BLOCK_CLASS_NAME=com.rwtema.extrautils2.quarry.TileQuarry, NANOS=35565449}
[09:47:47] [DedicatedServer]: 696 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=49, BLOCK_POS_Z=156, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=35498233}
[09:47:47] [DedicatedServer]: 690 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=115, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=35229271}
[09:47:47] [DedicatedServer]: 682 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=109, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=34783945}
[09:47:47] [DedicatedServer]: 681 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=50, BLOCK_POS_Z=159, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=34774876}
[09:47:47] [DedicatedServer]: 675 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=149, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=34462417}
[09:47:47] [DedicatedServer]: 673 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=138, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=34371492}
[09:47:47] [DedicatedServer]: 672 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=137, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=34309542}
[09:47:47] [DedicatedServer]: 657 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=125, BLOCK_POS_Y=55, BLOCK_POS_Z=192, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=33552221}
[09:47:47] [DedicatedServer]: 649 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=113, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=33133402}
[09:47:47] [DedicatedServer]: 642 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=127, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=32757113}
[09:47:47] [DedicatedServer]: 641 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=154, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=32720467}
[09:47:47] [DedicatedServer]: 634 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=122, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=32336221}
[09:47:47] [DedicatedServer]: 633 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=117, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=32296065}
[09:47:47] [DedicatedServer]: 627 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=108, BLOCK_POS_Y=49, BLOCK_POS_Z=158, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=31982967}
[09:47:47] [DedicatedServer]: 614 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=139, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=31351012}
[09:47:47] [DedicatedServer]: 614 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=148, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=31330390}
[09:47:47] [DedicatedServer]: 611 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=119, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=31182763}
[09:47:47] [DedicatedServer]: 604 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=128, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=30821802}
[09:47:47] [DedicatedServer]: 600 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=114, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=30636596}
[09:47:47] [DedicatedServer]: 597 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=130, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=30494291}
[09:47:47] [DedicatedServer]: 581 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=150, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=29656603}
[09:47:47] [DedicatedServer]: 578 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=136, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=29526386}
[09:47:47] [DedicatedServer]: 571 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=140, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=29169526}
[09:47:47] [DedicatedServer]: 569 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=131, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=29057165}
[09:47:47] [DedicatedServer]: 563 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=125, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=28717401}
[09:47:47] [DedicatedServer]: 560 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=118, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=28607477}
[09:47:47] [DedicatedServer]: 558 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=121, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=28485089}
[09:47:47] [DedicatedServer]: 555 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=146, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=28353618}
[09:47:47] [DedicatedServer]: 555 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=120, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=28332765}
[09:47:47] [DedicatedServer]: 540 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=116, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=27549158}
[09:47:47] [DedicatedServer]: 539 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=110, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=27521772}
[09:47:47] [DedicatedServer]: 537 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=112, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=27397026}
[09:47:47] [DedicatedServer]: 528 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TileMultipart_cmp$$0, BLOCK_POS_X=-197, BLOCK_POS_Y=113, BLOCK_POS_Z=503, BLOCK_CLASS_NAME=TileMultipart_cmp$$0, NANOS=26934730}
[09:47:47] [DedicatedServer]: 519 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=124, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=26471357}
[09:47:47] [DedicatedServer]: 508 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=ic2.te.ore_washing_plant, BLOCK_POS_X=-594, BLOCK_POS_Y=58, BLOCK_POS_Z=-2165, BLOCK_CLASS_NAME=ic2.core.block.machine.tileentity.TileEntityOreWashing, NANOS=25909332}
[09:47:47] [DedicatedServer]: 504 micro-s/t: TILE_ENTITY: {WORLD_ID=0, BLOCK_NAME=TilePipeHolder, BLOCK_POS_X=143, BLOCK_POS_Y=49, BLOCK_POS_Z=154, BLOCK_CLASS_NAME=buildcraft.transport.tile.TilePipeHolder, NANOS=25748230}
[...]

Finally, I extract the total usage with profile e command with TickProfile :

[EntityProfiler/INFO] [TickProfiler]:
TPS: 8.09919
                         Single Entity | Time/Tick |      %
   TileMultipart_cmp$$0 {-52,67,288}:0 |     9.862 | 17.762
tileentity.TileSmeltery {-62,65,289}:0 |     1.228 |  2.212
tileentity.TileSmeltery {-50,65,289}:0 |     1.122 |  2.020
    tile.TilePipeHolder {115,49,154}:0 |     0.837 |  1.477
    quarry.TileQuarry {147,63,-1271}:0 |     0.442 |  0.796
    
    Chunk | Time/Tick |      %
0: -4, 18 |    12.208 | 22.078
  0: 7, 9 |     9.109 | 16.474
  0: 8, 9 |     8.498 | 15.368
  0: 9, 9 |     7.663 | 13.858
  0: 6, 9 |     5.126 |  9.271

    All Entities of Type | Time/Tick |      %
     **tile.TilePipeHolder |    32.230 | 58.287**
    TileMultipart_cmp$$0 |    10.191 | 18.429
 tileentity.TileSmeltery |     2.461 |  4.450
TileEntityFieldProjector |     0.655 |  1.185
       quarry.TileQuarry |     0.519 |  0.939

       Average Entity of Type | Time/tick | Calls
         TileMultipart_cmp$$0 |     0.789 |  3170
  TileEntityOxygenDistributor |     0.145 |   244
      tileentity.TileSmeltery |     0.145 |  4163
            quarry.TileQuarry |     0.133 |   977
TileEntityEnergyStorageModule |     0.100 |   245

It seems that TilePipeHolder is using up to 58% of the total consumption.

(Note that I may be wrong, of all these interpretations, this is the first time I handle a server... So I'm still learning :') )

AlexIIL · Answer 5 · 2019-08-14T15:39:09.000Z

Ah ok, that would make more sense. In which case it would be very useful if you could take some more detailed performance information using VisualVM. Do you run the server locally or on a different machine that you don't have access to? (It's a lot easier to take a sample of a server running locally than remotely, but it's still possible).

Essentially I'd want a "CPU sample" (full instructions here), so that I can see what part of pipe's tick code is taking the longest time to run, so I know what part needs optimising.

Heap Dump

(Ideally I'd also want a Heap Dump, but that's *huge* - the same size as the amount of memory your server uses :/ (Open VisualVM, connect to the server, goto the "monitor" tab, click "Heap Dump", goto "applications" tab on the left, click "[heapdump] 00:00:00", then "File" > "Save As")).

Nallars · Answer 6 · 2019-08-14T16:41:21.000Z

The server is running on a VPS hosted by OVH (Ubuntu 18.04 iirc). I will check out how I can handle VisualVM with this.

A friend of mine is updating Buildcraft right now, so I will be able to tell you if the issue is still here soon.

Nallars · Answer 7 · 2019-08-15T21:14:02.000Z

Okay ! So we tried to update to the last version of BuildCraft and this didn't fix the issue.

I connected ingame and used LagGoggles UI to check what was really wrong and I saw it was juste a specific pipe network that causes lags.

This network :

starts with low µs/s then grow over time.

For the record it transport Liquid Exp.

I did a CPU sample here is the file :

ServerProfile.zip

If you really need the full Heap Dump, I will try to do, but i do need to clean some space on my server.

AlexIIL · Answer 8 · 2019-08-15T22:10:30.000Z

Heap Dump

No, sorry, don't bother - I wasn't thinking when i first asked for it - this should be enough.

AlexIIL · Answer 9 · 2019-08-18T16:04:28.000Z

I've done some work towards this in AlexIIL@2ce50a3 but it's not making enough of a difference to be useful so I'll have to come back to this later.

Share to