AliasAlreadyTaken reports: Add logging to command block e ... #4601

Closed
opened 2023-05-26 04:50:40 +00:00 by yourland-report · 5 comments

AliasAlreadyTaken reports a bug:

Add logging to command block execution

Player position:

{
	z = 1174.1019287109,
	x = 1979.3000488281,
	y = 18
}

Player look:

{
	z = -0.014274977147579,
	x = 0.99733859300613,
	y = -0.071497440338135
}

Player information:

{
	major = 5,
	ip_version = 6,
	min_rtt = 0.01799999922514,
	avg_rtt = 0.01799999922514,
	min_jitter = 0,
	minor = 8,
	avg_jitter = 0.0010000001639128,
	connection_uptime = 20415,
	serialization_version = 29,
	patch = 0,
	lang_code = "de",
	version_string = "5.8.0-yl_dev-180ec92ef",
	formspec_version = 6,
	max_rtt = 0.70200002193451,
	state = "Active",
	max_jitter = 0.68300002813339,
	protocol_version = 41
}

Player meta:

{
	fields = {
		["petz:werewolf_clan_idx"] = "4",
		arenalib_infobox_arenaID = "0",
		played_time = "81695979",
		digged_nodes = "139942",
		["arena_lib_editor.team_ID"] = "0",
		died = "1587",
		crafted = "4776",
		["arena_lib_editor.players_number"] = "0",
		["unified_inventory:bags"] = "return {\"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\"}",
		yl_commons_thankyou = "1016",
		yl_audio_state = "off",
		bitten = "0",
		punch_count = "63842",
		inflicted_damage = "2869862",
		yl_church = "return {[\"last_death\"] = {[\"z\"] = 1246, [\"x\"] = 2048, [\"y\"] = 10}, [\"last_death_portal\"] = 1683839371, [\"last_heal\"] = 1683837139}",
		["stamina:level"] = "14",
		repellant = "0",
		["stamina:poisoned"] = "no",
		["stamina:exhaustion"] = "118.5",
		["signslib:pos"] = "(2570,44,436)",
		xp_redo_hud_color = "0xFFFF00",
		["sethome:home"] = "(1983.4349365234,17.5,1183.5950927734)",
		["3d_armor_inventory"] = "return {\"\", \"\", \"\", \"\", \"\", \"\"}",
		["ocean_build.last_warning"] = "1.67421e+09",
		["ocean_build.forbidden"] = "true",
		["ocean_build.ocean_built"] = "12",
		["petz:lycanthropy"] = "0",
		["ethereal:fly_timer"] = "-99",
		["petz:werewolf_vignette_id"] = "19",
		szutil_watch = "return {}",
		hud_state = "on",
		partychat = "party",
		["petz:werewolf"] = "0",
		xp = "0",
		lagometer = "1",
		["arena_lib_editor.spawner_ID"] = "0",
		["petz:old_override_table"] = "return {[\"speed\"] = 1, [\"new_move\"] = true, [\"sneak_glitch\"] = false, [\"gravity\"] = 1, [\"jump\"] = 1, [\"sneak\"] = true}",
		yl_commons_player_joined = "1685056232",
		placed_nodes = "180376",
		arenalib_watchID = "0",
		team = "STAFF"
	}
}

Log identifier


[MOD] yl_report log identifier = dlHz0TvJXlvSNlS390fKb19gz7hJhh28

Profiler save:

profile-20230526T045040.json_prettyEE

Status:

# Server: version: 5.6.1-yl | game: Minetest Game | uptime: 3d 10h 30min 59s | max lag: 0.879s | clients (16/52): 9T9, AliasAlreadyTaken, Azelf, Bailiff, bizon, daydream, Dirac, Electro98, HorusDamocles, Moonlife, mrminer, Oblivion12, Service, tagtraum, TheOnlyPlayerJ, whymebob

Teleport command:

/teleport xyz 1979 18 1174

Compass command:

/give_compass Construction dlHz0TvJXlvSNlS390fKb19gz7hJhh28 D2691E 1979 18 1174
AliasAlreadyTaken reports a bug: > Add logging to command block execution Player position: ``` { z = 1174.1019287109, x = 1979.3000488281, y = 18 } ``` Player look: ``` { z = -0.014274977147579, x = 0.99733859300613, y = -0.071497440338135 } ``` Player information: ``` { major = 5, ip_version = 6, min_rtt = 0.01799999922514, avg_rtt = 0.01799999922514, min_jitter = 0, minor = 8, avg_jitter = 0.0010000001639128, connection_uptime = 20415, serialization_version = 29, patch = 0, lang_code = "de", version_string = "5.8.0-yl_dev-180ec92ef", formspec_version = 6, max_rtt = 0.70200002193451, state = "Active", max_jitter = 0.68300002813339, protocol_version = 41 } ``` Player meta: ``` { fields = { ["petz:werewolf_clan_idx"] = "4", arenalib_infobox_arenaID = "0", played_time = "81695979", digged_nodes = "139942", ["arena_lib_editor.team_ID"] = "0", died = "1587", crafted = "4776", ["arena_lib_editor.players_number"] = "0", ["unified_inventory:bags"] = "return {\"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\", \"unified_inventory:bag_large\"}", yl_commons_thankyou = "1016", yl_audio_state = "off", bitten = "0", punch_count = "63842", inflicted_damage = "2869862", yl_church = "return {[\"last_death\"] = {[\"z\"] = 1246, [\"x\"] = 2048, [\"y\"] = 10}, [\"last_death_portal\"] = 1683839371, [\"last_heal\"] = 1683837139}", ["stamina:level"] = "14", repellant = "0", ["stamina:poisoned"] = "no", ["stamina:exhaustion"] = "118.5", ["signslib:pos"] = "(2570,44,436)", xp_redo_hud_color = "0xFFFF00", ["sethome:home"] = "(1983.4349365234,17.5,1183.5950927734)", ["3d_armor_inventory"] = "return {\"\", \"\", \"\", \"\", \"\", \"\"}", ["ocean_build.last_warning"] = "1.67421e+09", ["ocean_build.forbidden"] = "true", ["ocean_build.ocean_built"] = "12", ["petz:lycanthropy"] = "0", ["ethereal:fly_timer"] = "-99", ["petz:werewolf_vignette_id"] = "19", szutil_watch = "return {}", hud_state = "on", partychat = "party", ["petz:werewolf"] = "0", xp = "0", lagometer = "1", ["arena_lib_editor.spawner_ID"] = "0", ["petz:old_override_table"] = "return {[\"speed\"] = 1, [\"new_move\"] = true, [\"sneak_glitch\"] = false, [\"gravity\"] = 1, [\"jump\"] = 1, [\"sneak\"] = true}", yl_commons_player_joined = "1685056232", placed_nodes = "180376", arenalib_watchID = "0", team = "STAFF" } } ``` Log identifier ``` [MOD] yl_report log identifier = dlHz0TvJXlvSNlS390fKb19gz7hJhh28 ``` Profiler save: ``` profile-20230526T045040.json_prettyEE ``` Status: ``` # Server: version: 5.6.1-yl | game: Minetest Game | uptime: 3d 10h 30min 59s | max lag: 0.879s | clients (16/52): 9T9, AliasAlreadyTaken, Azelf, Bailiff, bizon, daydream, Dirac, Electro98, HorusDamocles, Moonlife, mrminer, Oblivion12, Service, tagtraum, TheOnlyPlayerJ, whymebob ``` Teleport command: ``` /teleport xyz 1979 18 1174 ``` Compass command: ``` /give_compass Construction dlHz0TvJXlvSNlS390fKb19gz7hJhh28 D2691E 1979 18 1174 ```
AliasAlreadyTaken was assigned by yourland-report 2023-05-26 04:50:40 +00:00

I found this in the log:

2023-05-23 15:08:44: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"
2023-05-23 15:08:44: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"
2023-05-23 15:08:44: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"
2023-05-23 15:09:57: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"
2023-05-23 15:09:57: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"
2023-05-23 15:09:58: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"

Since Arabella wasn't online for a while, we suspect a command block sends those. The entity never gets spawned:

2023-05-23 15:09:58: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem"
2023-05-23 15:09:58: ERROR[Server]: Unable to spawn entity, player is nil

So let's add to init.lua:

local commands = resolve_commands(meta:get_string("commands"), pos)
core.log("warning","[mesecons_commandblock] Commandblock at pos ".. dump(pos) .. " executes " .. dump(commands))
I found this in the log: ``` 2023-05-23 15:08:44: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" 2023-05-23 15:08:44: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" 2023-05-23 15:08:44: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" 2023-05-23 15:09:57: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" 2023-05-23 15:09:57: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" 2023-05-23 15:09:58: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" ``` Since Arabella wasn't online for a while, we suspect a command block sends those. The entity never gets spawned: ``` 2023-05-23 15:09:58: ACTION[Server]: Arabella invokes /spawnentity, entityname="petz:elephant_fem" 2023-05-23 15:09:58: ERROR[Server]: Unable to spawn entity, player is nil ``` So let's add to init.lua: ``` local commands = resolve_commands(meta:get_string("commands"), pos) core.log("warning","[mesecons_commandblock] Commandblock at pos ".. dump(pos) .. " executes " .. dump(commands)) ```
AliasAlreadyTaken added the
3. source/unknown
1. kind/bug
3. source/ingame
labels 2023-05-26 11:56:53 +00:00

can I suggest a subYL mod aswell as ingame detection,
something I did when mapped and such.
Would make good antigrief and hack detection.

can I suggest a subYL mod aswell as ingame detection, something I did when mapped and such. Would make good antigrief and hack detection.

Can you elaborate on what a subYL mod should do? Also, what kind of ingame detection would you need and what would it detect?

Can you elaborate on what a subYL mod should do? Also, what kind of ingame detection would you need and what would it detect?
Member

Created a PR for logging:
your-land/yl_commons#20

Created a PR for logging: https://gitea.your-land.de/your-land/yl_commons/pulls/20

This is ingame by now :D

This is ingame by now :D
AliasAlreadyTaken added the
5. result/fixed
label 2023-12-08 05:55:36 +00:00
Sign in to join this conversation.
No Milestone
No project
No Assignees
4 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#4601
No description provided.