HorusDamocles reports: weird lag 10 second reversion. ... #1975

Open
opened 2022-05-25 07:49:21 +00:00 by yourland-report · 3 comments

HorusDamocles reports a bug:

weird lag 10 second reversion.

Player position:

{
	y = 21.5,
	x = 16995.306640625,
	z = -13127.810546875
}

Player look:

{
	y = -0.34693562984467,
	x = 0.92112267017365,
	z = 0.17654649913311
}

Player information:

{
	min_rtt = 0.14499999582767,
	max_rtt = 0.81000000238419,
	connection_uptime = 15585,
	max_jitter = 0.63899999856949,
	minor = 5,
	major = 5,
	ip_version = 6,
	formspec_version = 5,
	patch = 0,
	protocol_version = 40,
	serialization_version = 29,
	lang_code = "",
	version_string = "5.5.0",
	avg_rtt = 0.14900000393391,
	state = "Active",
	avg_jitter = 0,
	min_jitter = 0
}

Player meta:

{
	fields = {
		["3d_armor_inventory"] = "return {\"3d_armor:boots_crystal 1 7160\", \"3d_armor:enchanted_chestplate_diamond_strong 1 7520\", \"shields:shield_crystal 1 6380\", \"3d_armor:enchanted_helmet_diamond_strong 1 7520\", \"3d_armor:enchanted_leggings_diamond_strong 1 13440\", \"\"}",
		["petz:werewolf_vignette_id"] = "5",
		played_time = "1156415",
		["ocean_build.ocean_built"] = "1",
		jointime = "1651436734",
		["stamina:poisoned"] = "no",
		["stamina:exhaustion"] = "11.5",
		["signslib:pos"] = "(16953,57,-15009)",
		["ocean_build.last_warning"] = "1.65337e+09",
		digged_nodes = "387541",
		yl_commons_player_joined = "1653449474",
		bitten = "0",
		["unified_inventory:bags"] = "return {\"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\"}",
		["petz:werewolf"] = "0",
		punch_count = "5806",
		["petz:lycanthropy"] = "1",
		yl_church = "return {[\"last_death\"] = {[\"y\"] = -3, [\"x\"] = 13127, [\"z\"] = 13816}, [\"last_death_portal\"] = 1653370571}",
		["petz:werewolf_clan_idx"] = "3",
		["stamina:level"] = "17",
		xp = "369901",
		arenalib_infobox_arenaID = "0",
		inflicted_damage = "85016",
		crafted = "979",
		["petz:old_override_table"] = "return {[\"new_move\"] = true, [\"sneak\"] = true, [\"sneak_glitch\"] = false, [\"jump\"] = 1.5, [\"speed\"] = 1.8899999856948853, [\"gravity\"] = 1.1100000143051147}",
		yl_commons_thankyou = "22",
		placed_nodes = "93928",
		died = "127",
		hud_state = "on",
		repellant = "0",
		yl_commons_player_created = "1651436734"
	}
}

Log identifier


[MOD] yl_report log identifier = zAANc0JM4cupNBOzM1fhn8Ben1iRZPYP

Profiler save:

profile-20220525T094921.json_prettyEE

Status:

# Server: version: 5.5.0-yl | game: Minetest Game | uptime: 3d 17h 6min 32s | max lag: 110s | clients: rohit, phantom, Shershaah, HorusDamocles, bluattire, Bailiff, Service, AliasAlreadyTaken, Lupercus, pitman

Teleport command:

/teleport xyz 16995 22 -13128

Compass command:

/give_compass Construction zAANc0JM4cupNBOzM1fhn8Ben1iRZPYP D2691E 16995 22 -13128
HorusDamocles reports a bug: > weird lag 10 second reversion. Player position: ``` { y = 21.5, x = 16995.306640625, z = -13127.810546875 } ``` Player look: ``` { y = -0.34693562984467, x = 0.92112267017365, z = 0.17654649913311 } ``` Player information: ``` { min_rtt = 0.14499999582767, max_rtt = 0.81000000238419, connection_uptime = 15585, max_jitter = 0.63899999856949, minor = 5, major = 5, ip_version = 6, formspec_version = 5, patch = 0, protocol_version = 40, serialization_version = 29, lang_code = "", version_string = "5.5.0", avg_rtt = 0.14900000393391, state = "Active", avg_jitter = 0, min_jitter = 0 } ``` Player meta: ``` { fields = { ["3d_armor_inventory"] = "return {\"3d_armor:boots_crystal 1 7160\", \"3d_armor:enchanted_chestplate_diamond_strong 1 7520\", \"shields:shield_crystal 1 6380\", \"3d_armor:enchanted_helmet_diamond_strong 1 7520\", \"3d_armor:enchanted_leggings_diamond_strong 1 13440\", \"\"}", ["petz:werewolf_vignette_id"] = "5", played_time = "1156415", ["ocean_build.ocean_built"] = "1", jointime = "1651436734", ["stamina:poisoned"] = "no", ["stamina:exhaustion"] = "11.5", ["signslib:pos"] = "(16953,57,-15009)", ["ocean_build.last_warning"] = "1.65337e+09", digged_nodes = "387541", yl_commons_player_joined = "1653449474", bitten = "0", ["unified_inventory:bags"] = "return {\"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\"}", ["petz:werewolf"] = "0", punch_count = "5806", ["petz:lycanthropy"] = "1", yl_church = "return {[\"last_death\"] = {[\"y\"] = -3, [\"x\"] = 13127, [\"z\"] = 13816}, [\"last_death_portal\"] = 1653370571}", ["petz:werewolf_clan_idx"] = "3", ["stamina:level"] = "17", xp = "369901", arenalib_infobox_arenaID = "0", inflicted_damage = "85016", crafted = "979", ["petz:old_override_table"] = "return {[\"new_move\"] = true, [\"sneak\"] = true, [\"sneak_glitch\"] = false, [\"jump\"] = 1.5, [\"speed\"] = 1.8899999856948853, [\"gravity\"] = 1.1100000143051147}", yl_commons_thankyou = "22", placed_nodes = "93928", died = "127", hud_state = "on", repellant = "0", yl_commons_player_created = "1651436734" } } ``` Log identifier ``` [MOD] yl_report log identifier = zAANc0JM4cupNBOzM1fhn8Ben1iRZPYP ``` Profiler save: ``` profile-20220525T094921.json_prettyEE ``` Status: ``` # Server: version: 5.5.0-yl | game: Minetest Game | uptime: 3d 17h 6min 32s | max lag: 110s | clients: rohit, phantom, Shershaah, HorusDamocles, bluattire, Bailiff, Service, AliasAlreadyTaken, Lupercus, pitman ``` Teleport command: ``` /teleport xyz 16995 22 -13128 ``` Compass command: ``` /give_compass Construction zAANc0JM4cupNBOzM1fhn8Ben1iRZPYP D2691E 16995 22 -13128 ```
AliasAlreadyTaken was assigned by yourland-report 2022-05-25 07:49:21 +00:00
AliasAlreadyTaken added the
3. source/lag
label 2022-05-25 12:39:38 +00:00

From the Status: max lag: 110s

From the Status: max lag: 110s
 yl_matterbridge:                                        |        44 | 116727390 |       848 |   0.0 |  99.9 |   2.4
  - globalstep[1] .....................................  |        44 | 116727390 |       848 |   0.0 |  99.9 |   2.4

So yl_matterbridge blocked the server for 116 727 390 us, that's 116.7 seconds.

The standstill happened between

2022-05-25 09:46:19 and 2022-05-25 09:48:16

``` yl_matterbridge: | 44 | 116727390 | 848 | 0.0 | 99.9 | 2.4 - globalstep[1] ..................................... | 44 | 116727390 | 848 | 0.0 | 99.9 | 2.4 ``` So yl_matterbridge blocked the server for 116 727 390 us, that's 116.7 seconds. The standstill happened between 2022-05-25 09:46:19 and 2022-05-25 09:48:16

This were the actions of the bridge around this times:

2022-05-25 09:44:54: ACTION[Server]: [MOD] smart_chat : Module matterbridge: send_2_bridge: oh ok
2022-05-25 09:48:16: ACTION[Server]: [MOD] smart_chat : Module core: *** leaves the World.
2022-05-25 09:48:16: ACTION[Server]: [MOD] smart_chat : Module core: *** leaves the World.
2022-05-25 09:48:30: [Server]: [MOD] smart_chat : Module lib: chat: <HorusDamocles> that was weird, just ported like 20 nodes
This were the actions of the bridge around this times: ``` 2022-05-25 09:44:54: ACTION[Server]: [MOD] smart_chat : Module matterbridge: send_2_bridge: oh ok 2022-05-25 09:48:16: ACTION[Server]: [MOD] smart_chat : Module core: *** leaves the World. 2022-05-25 09:48:16: ACTION[Server]: [MOD] smart_chat : Module core: *** leaves the World. 2022-05-25 09:48:30: [Server]: [MOD] smart_chat : Module lib: chat: <HorusDamocles> that was weird, just ported like 20 nodes ```
AliasAlreadyTaken added the
1. kind/bug
label 2022-05-25 14:01:27 +00:00
Sign in to join this conversation.
No Milestone
No project
No Assignees
2 Participants
Notifications
Due Date
The due date is invalid or out of range. Please use the format 'yyyy-mm-dd'.

No due date set.

Dependencies

No dependencies set.

Reference: your-land/bugtracker#1975
No description provided.