mirror of
https://github.com/ChuckBuilds/LEDMatrix.git
synced 2026-08-21 10:29:06 +00:00
Compare commits
| Author | SHA1 | Date | |
|---|---|---|---|
|
|
b7a7e26bfe |
+63
-1
@@ -111,6 +111,12 @@ class RestoreOptions:
|
||||
"""Which sections of a backup should be restored."""
|
||||
|
||||
restore_config: bool = True
|
||||
#: Whether to take the backup's display.hardware block as well.
|
||||
#: Off by default: that block describes the panel physically wired to
|
||||
#: *this* device -- its size, chain length, mapping, multiplexing and
|
||||
#: refresh cap. A backup carries the panel of the machine it was taken
|
||||
#: on, and restoring one onto a different rig drives the wrong geometry.
|
||||
restore_hardware: bool = False
|
||||
restore_secrets: bool = True
|
||||
restore_wifi: bool = True
|
||||
restore_fonts: bool = True
|
||||
@@ -549,6 +555,60 @@ def _copy_file(src: Path, dst: Path) -> None:
|
||||
raise
|
||||
|
||||
|
||||
_HARDWARE_PATH = ("display", "hardware")
|
||||
|
||||
|
||||
def _restore_config_preserving_hardware(src: Path, dst: Path, keep_hardware: bool) -> None:
|
||||
"""Copy a backed-up config.json, optionally keeping the local panel block.
|
||||
|
||||
display.hardware describes the panel physically attached to this device:
|
||||
cols, rows, chain_length, hardware_mapping, panel_type, multiplexing and
|
||||
the refresh-rate cap. None of that travels with a configuration -- it is a
|
||||
property of the machine. Restoring a backup taken on a 512x64 rig onto a
|
||||
128x32 one used to overwrite the smaller panel's geometry with the larger
|
||||
one's, which is not a setting the user can see going wrong; the display
|
||||
simply stops being right.
|
||||
|
||||
Falls back to a plain copy when either file cannot be parsed, so a restore
|
||||
never fails because of this.
|
||||
"""
|
||||
if not keep_hardware:
|
||||
_copy_file(src, dst)
|
||||
return
|
||||
try:
|
||||
incoming = json.loads(src.read_text(encoding="utf-8"))
|
||||
local = json.loads(dst.read_text(encoding="utf-8")) if dst.exists() else {}
|
||||
except (OSError, ValueError) as exc:
|
||||
logger.warning(
|
||||
"[Backup] Could not merge local panel config (%s); restoring the "
|
||||
"backup's config.json as-is", exc)
|
||||
_copy_file(src, dst)
|
||||
return
|
||||
|
||||
section, key = _HARDWARE_PATH
|
||||
local_hw = (local.get(section) or {}).get(key)
|
||||
if not isinstance(local_hw, dict) or not local_hw:
|
||||
_copy_file(src, dst)
|
||||
return
|
||||
|
||||
if not isinstance(incoming.get(section), dict):
|
||||
incoming[section] = {}
|
||||
incoming_hw = incoming[section].get(key)
|
||||
incoming[section][key] = local_hw
|
||||
if isinstance(incoming_hw, dict) and incoming_hw != local_hw:
|
||||
logger.info(
|
||||
"[Backup] Kept this device's display.hardware; the backup's panel "
|
||||
"was %sx%s chain %s, this one is %sx%s chain %s",
|
||||
incoming_hw.get("cols"), incoming_hw.get("rows"),
|
||||
incoming_hw.get("chain_length"),
|
||||
local_hw.get("cols"), local_hw.get("rows"),
|
||||
local_hw.get("chain_length"))
|
||||
|
||||
tmp_path = dst.with_suffix(dst.suffix + ".restore-tmp")
|
||||
tmp_path.write_text(json.dumps(incoming, indent=2) + "\n", encoding="utf-8")
|
||||
os.replace(tmp_path, dst)
|
||||
|
||||
|
||||
def restore_backup(
|
||||
zip_path: Path,
|
||||
project_root: Path,
|
||||
@@ -584,7 +644,9 @@ def restore_backup(
|
||||
# Main config.
|
||||
if options.restore_config and (tmp_dir / _CONFIG_REL).exists():
|
||||
try:
|
||||
_copy_file(tmp_dir / _CONFIG_REL, project_root / _CONFIG_REL)
|
||||
_restore_config_preserving_hardware(
|
||||
tmp_dir / _CONFIG_REL, project_root / _CONFIG_REL,
|
||||
keep_hardware=not options.restore_hardware)
|
||||
result.restored.append("config")
|
||||
except OSError as e:
|
||||
logger.error("[Backup] Failed to restore config.json: %s", e, exc_info=True)
|
||||
|
||||
+1
-54
@@ -130,12 +130,7 @@ def setup_logging(
|
||||
# Console handler (always add)
|
||||
console_handler = logging.StreamHandler(sys.stdout)
|
||||
console_handler.setLevel(level)
|
||||
# Under systemd, tag each line so the journal records the real severity
|
||||
# rather than filing everything as informational. The file handler below
|
||||
# keeps the plain formatter: the prefix is meaningful to journald and noise
|
||||
# anywhere else.
|
||||
console_handler.setFormatter(
|
||||
JournalPriorityFormatter(formatter) if _under_systemd() else formatter)
|
||||
console_handler.setFormatter(formatter)
|
||||
root_logger.addHandler(console_handler)
|
||||
|
||||
# File handler (if specified)
|
||||
@@ -150,54 +145,6 @@ def setup_logging(
|
||||
sys.stderr.write(f"Warning: Could not set up file logging to {log_file}: {e}\n")
|
||||
|
||||
|
||||
#: syslog priorities, which is what systemd parses from a "<N>" prefix on
|
||||
#: stdout. Mapped from Python's levels.
|
||||
_SYSLOG_PRIORITY = {
|
||||
logging.CRITICAL: 2, # LOG_CRIT
|
||||
logging.ERROR: 3, # LOG_ERR
|
||||
logging.WARNING: 4, # LOG_WARNING
|
||||
logging.INFO: 6, # LOG_INFO
|
||||
logging.DEBUG: 7, # LOG_DEBUG
|
||||
}
|
||||
|
||||
|
||||
class JournalPriorityFormatter(logging.Formatter):
|
||||
"""Wraps a formatter, prefixing each line with its syslog priority.
|
||||
|
||||
Under systemd everything this process writes to stdout lands in the journal
|
||||
as PRIORITY=6, whatever the Python level was. Measured on a live rig: 55
|
||||
ERROR lines and 13 WARNING lines in a day, every one of them recorded as
|
||||
informational, so `journalctl -p err -u ledmatrix` returned nothing at all
|
||||
while errors were being logged. Anyone triaging has to grep the message
|
||||
text instead, which is both slower and wrong -- a search for "oom" matches
|
||||
the radar logging "zoom=9".
|
||||
|
||||
systemd reads a leading "<N>" on each line and uses it as the priority
|
||||
(sd-daemon(3)), so this needs no extra dependency. Multi-line records get
|
||||
the prefix on every line, since the journal splits them and an unprefixed
|
||||
continuation would fall back to the default.
|
||||
"""
|
||||
|
||||
def __init__(self, inner: logging.Formatter):
|
||||
super().__init__()
|
||||
self._inner = inner
|
||||
|
||||
def format(self, record: logging.LogRecord) -> str:
|
||||
text = self._inner.format(record)
|
||||
prefix = f"<{_SYSLOG_PRIORITY.get(record.levelno, 6)}>"
|
||||
return "\n".join(prefix + line for line in text.split("\n"))
|
||||
|
||||
|
||||
def _under_systemd() -> bool:
|
||||
"""True when stdout is the journal.
|
||||
|
||||
systemd sets JOURNAL_STREAM for services whose output it captures. Without
|
||||
this check the "<N>" prefixes would show up as literal noise when the
|
||||
program is run from a terminal, in the emulator, or in tests.
|
||||
"""
|
||||
return bool(os.environ.get("JOURNAL_STREAM"))
|
||||
|
||||
|
||||
class PluginLoggerAdapter(logging.LoggerAdapter):
|
||||
"""LoggerAdapter that stamps every record with its plugin_id.
|
||||
|
||||
|
||||
@@ -1,101 +0,0 @@
|
||||
"""Log lines must reach the journal with their real severity.
|
||||
|
||||
Everything this process writes to stdout lands in the journal as PRIORITY=6,
|
||||
whatever the Python level was, because journald has no other signal. Measured
|
||||
on a live rig over 24 hours: 55 lines containing " - ERROR - " and 13
|
||||
containing " - WARNING - ", every one of them recorded as informational. So
|
||||
|
||||
journalctl -p err -u ledmatrix
|
||||
|
||||
returned nothing while errors were being logged, and anyone triaging has to
|
||||
grep the message text instead. That is slower and it is wrong: a search for
|
||||
"oom" also matches the radar logging "zoom=9", which is exactly the false
|
||||
positive it produced during this audit.
|
||||
|
||||
systemd reads a leading "<N>" on each stdout line and uses it as the priority
|
||||
(sd-daemon(3)), so this needs no extra dependency -- and it must only be
|
||||
applied when systemd is actually reading, or the prefixes become literal noise
|
||||
in a terminal, the emulator, and test output.
|
||||
"""
|
||||
import logging
|
||||
import os
|
||||
from unittest.mock import patch
|
||||
|
||||
import pytest
|
||||
|
||||
from src.logging_config import JournalPriorityFormatter, _SYSLOG_PRIORITY, _under_systemd
|
||||
|
||||
|
||||
class _Plain(logging.Formatter):
|
||||
def format(self, record):
|
||||
return record.getMessage()
|
||||
|
||||
|
||||
def _record(level, msg="hello"):
|
||||
return logging.LogRecord("t", level, "f.py", 1, msg, None, None)
|
||||
|
||||
|
||||
@pytest.mark.parametrize("level,expected", [
|
||||
(logging.CRITICAL, 2),
|
||||
(logging.ERROR, 3),
|
||||
(logging.WARNING, 4),
|
||||
(logging.INFO, 6),
|
||||
(logging.DEBUG, 7),
|
||||
])
|
||||
def test_each_level_maps_to_its_syslog_priority(level, expected):
|
||||
out = JournalPriorityFormatter(_Plain()).format(_record(level))
|
||||
assert out.startswith(f"<{expected}>"), out
|
||||
assert _SYSLOG_PRIORITY[level] == expected
|
||||
|
||||
|
||||
def test_error_and_info_are_distinguishable():
|
||||
"""The whole point: journalctl -p err must be able to tell them apart."""
|
||||
fmt = JournalPriorityFormatter(_Plain())
|
||||
assert fmt.format(_record(logging.ERROR))[:3] != fmt.format(_record(logging.INFO))[:3]
|
||||
|
||||
|
||||
def test_every_line_of_a_multiline_record_is_tagged():
|
||||
"""The journal splits them, and an untagged continuation loses its level.
|
||||
|
||||
A traceback is the case that matters -- it is the most important thing in
|
||||
the log and the longest.
|
||||
"""
|
||||
out = JournalPriorityFormatter(_Plain()).format(
|
||||
_record(logging.ERROR, "Traceback:\nline one\nline two"))
|
||||
lines = out.split("\n")
|
||||
assert len(lines) == 3
|
||||
assert all(line.startswith("<3>") for line in lines), lines
|
||||
|
||||
|
||||
def test_the_message_survives_intact():
|
||||
out = JournalPriorityFormatter(_Plain()).format(_record(logging.WARNING, "disk full"))
|
||||
assert out == "<4>disk full"
|
||||
|
||||
|
||||
def test_an_unknown_level_falls_back_to_info():
|
||||
out = JournalPriorityFormatter(_Plain()).format(_record(25))
|
||||
assert out.startswith("<6>")
|
||||
|
||||
|
||||
def test_prefixing_is_off_outside_systemd():
|
||||
"""Otherwise a terminal run, the emulator and pytest all show `<6>`."""
|
||||
with patch.dict(os.environ, {}, clear=True):
|
||||
assert not _under_systemd()
|
||||
with patch.dict(os.environ, {"JOURNAL_STREAM": "8:12345"}):
|
||||
assert _under_systemd()
|
||||
|
||||
|
||||
def test_setup_uses_the_wrapper_only_under_systemd():
|
||||
from src.logging_config import setup_logging
|
||||
|
||||
for env, expect_wrapped in (({}, False), ({"JOURNAL_STREAM": "8:1"}, True)):
|
||||
with patch.dict(os.environ, env, clear=True):
|
||||
setup_logging()
|
||||
handlers = [h for h in logging.getLogger().handlers
|
||||
if isinstance(h, logging.StreamHandler)]
|
||||
assert handlers, "no stream handler installed"
|
||||
wrapped = any(isinstance(h.formatter, JournalPriorityFormatter)
|
||||
for h in handlers)
|
||||
assert wrapped is expect_wrapped, (
|
||||
f"JOURNAL_STREAM={env}: wrapped={wrapped}, expected {expect_wrapped}")
|
||||
logging.getLogger().handlers.clear()
|
||||
@@ -0,0 +1,75 @@
|
||||
#!/usr/bin/env python3
|
||||
"""A restore must not repoint this device at another machine's panel.
|
||||
|
||||
display.hardware describes the panel physically wired to this device -- cols,
|
||||
rows, chain_length, hardware_mapping, panel_type, multiplexing, the refresh
|
||||
cap. A backup carries the panel of the machine it was taken on. Restoring a
|
||||
512x64 rig's backup onto a 128x32 one used to overwrite the smaller panel's
|
||||
geometry with the larger one's, and nothing on screen explains why: the
|
||||
display just stops being right.
|
||||
|
||||
That is not hypothetical. It happened, and the rig it happened to had to be
|
||||
reflashed.
|
||||
"""
|
||||
import json
|
||||
import sys
|
||||
from pathlib import Path
|
||||
|
||||
sys.path.insert(0, str(Path(__file__).resolve().parent.parent))
|
||||
|
||||
from src.backup_manager import _restore_config_preserving_hardware # noqa: E402
|
||||
|
||||
BIG = {"display": {"hardware": {"cols": 128, "rows": 64, "chain_length": 4,
|
||||
"hardware_mapping": "adafruit-hat-pwm"},
|
||||
"runtime": {"gpio_slowdown": 4}},
|
||||
"timezone": "America/New_York", "some-plugin": {"enabled": True}}
|
||||
SMALL = {"display": {"hardware": {"cols": 64, "rows": 32, "chain_length": 2,
|
||||
"hardware_mapping": "regular"},
|
||||
"runtime": {"gpio_slowdown": 2}},
|
||||
"timezone": "UTC"}
|
||||
|
||||
|
||||
def _run(tmp, keep):
|
||||
src = tmp / "backup_config.json"; src.write_text(json.dumps(BIG))
|
||||
dst = tmp / "config.json"; dst.write_text(json.dumps(SMALL))
|
||||
_restore_config_preserving_hardware(src, dst, keep_hardware=keep)
|
||||
return json.loads(dst.read_text())
|
||||
|
||||
|
||||
def test_local_panel_survives(tmp_path):
|
||||
out = _run(tmp_path, keep=True)
|
||||
hw = out["display"]["hardware"]
|
||||
assert (hw["cols"], hw["rows"], hw["chain_length"]) == (64, 32, 2), (
|
||||
"the restore repointed this device at the backup's panel")
|
||||
assert hw["hardware_mapping"] == "regular", "panel wiring came from the backup"
|
||||
|
||||
|
||||
def test_everything_else_is_restored(tmp_path):
|
||||
out = _run(tmp_path, keep=True)
|
||||
assert out["timezone"] == "America/New_York", "config was not restored"
|
||||
assert out["some-plugin"] == {"enabled": True}, "plugin config was not restored"
|
||||
assert out["display"]["runtime"] == {"gpio_slowdown": 4}, (
|
||||
"only display.hardware should be held back")
|
||||
|
||||
|
||||
def test_opting_in_takes_the_backups_panel(tmp_path):
|
||||
out = _run(tmp_path, keep=False)
|
||||
hw = out["display"]["hardware"]
|
||||
assert (hw["cols"], hw["rows"], hw["chain_length"]) == (128, 64, 4)
|
||||
|
||||
|
||||
def test_a_device_with_no_local_hardware_takes_the_backups(tmp_path):
|
||||
src = tmp_path / "b.json"; src.write_text(json.dumps(BIG))
|
||||
dst = tmp_path / "c.json"; dst.write_text(json.dumps({"timezone": "UTC"}))
|
||||
_restore_config_preserving_hardware(src, dst, keep_hardware=True)
|
||||
out = json.loads(dst.read_text())
|
||||
assert out["display"]["hardware"]["cols"] == 128, (
|
||||
"nothing local to preserve, so the backup's panel should be used")
|
||||
|
||||
|
||||
def test_unparseable_local_config_still_restores(tmp_path):
|
||||
src = tmp_path / "b.json"; src.write_text(json.dumps(BIG))
|
||||
dst = tmp_path / "c.json"; dst.write_text("{ not json")
|
||||
_restore_config_preserving_hardware(src, dst, keep_hardware=True)
|
||||
assert json.loads(dst.read_text())["timezone"] == "America/New_York", (
|
||||
"a restore must never fail because of this merge")
|
||||
Reference in New Issue
Block a user