# provenance (ASCII header; payload below is the verbatim boot_log from run_boot_test.py)
# commit      : 77779d49  (branch v2-on-ui)  -- built in a READ-ONLY detached worktree
#               D:/Code/DTU Code/_wt/bench-21-77779d49  (main tree had another lane's in-flight
#               doc edits at the time, so the image was deliberately NOT built from the main tree)
# build       : @build 2026-10-26 16:27, rc=0, "0 Error(s), 0 Warning(s)"
#               Program Size: Code=228260 RO-data=24960 RW-data=1440 ZI-data=135976
# image stamp : fw build: Oct 26 2026 16:27:01 suite=NONE dstr=off  (product build, destructive OFF;
#               extracted from the .hex binary AND matched on the wire)
# flash       : stlink_flash.py flash = -P 0x08000000 -Rst -Run ; Programming Complete ; rc=0
# readback    : stlink_flash.py cmp (-CmpFile) run AFTER log capture -> READBACK: OK (no difference found)
# verdict     : PASS (run_boot_test rc=0) -- 9/9 Required, Forbidden 0 hits ([ERR]=0 Fault=0 FAIL=0 ERROR=0),
#               anchor 'reset cause:' x1 (CSR=0x14000000 software NVIC_SystemReset), marker order ok,
#               boot time to 'net init: OK' = +762 ms ; water levels: see the [STACK] lines below

[+0ms] [----/--/-- --:--:--][APP] boot: syslog init OK
[+0ms] [----/--/-- --:--:--][APP] fw build: Oct 26 2026 16:27:01 suite=NONE dstr=off
[+11ms] [----/--/-- --:--:--][APP] reset cause: software (NVIC_SystemReset) (CSR=0x14000000)
[+11ms] PREVRUN seg=2 seq=2156097806 t=77731647
[+21ms] TICKRUN uw=77731656 n=77731656 duw=9
[+21ms] [----/--/-- --:--:--][RTC] sd2506_init: OK
[+32ms] [----/--/-- --:--:--][APP] SD2506 init: OK (ret=0)
[+32ms] [2026-10-26 08:28:27][CLK] sys_clock_init: RTC initial time 2026-10-26 08:28:27
[+42ms] [2026-10-26 08:28:27][CLK] sys_clock_init: wall clock base = unix 1793003307, base_tick=139
[+53ms] [2026-10-26 08:28:27][APP] RS485 init: OK (UART4, DE=PA15)
[+63ms] [2026-10-26 08:28:27][NAND] Resetting NAND...
[+84ms] [2026-10-26 08:28:27][NAND] Reading NAND ID...
[+84ms] [2026-10-26 08:28:27][NAND] NAND ID: MID=0xC8, DID=0x52
[+94ms] [2026-10-26 08:28:27][NAND] Scanning bad blocks...
[+229ms] [2026-10-26 08:28:27][NAND] BBT scan: 0 bad blocks found
[+229ms] [2026-10-26 08:28:27][NAND] Enabling ECC...
[+229ms] [2026-10-26 08:28:27][NAND] Unlocking block protection...
[+240ms] [2026-10-26 08:28:27][NAND] Locating BBT pool...
[+240ms] [2026-10-26 08:28:27][NAND] Loading persisted BBT...
[+250ms] [2026-10-26 08:28:27][NAND] NAND init OK
[+250ms] [2026-10-26 08:28:27][APP] NAND init: OK
[+261ms] [2026-10-26 08:28:27][ADC] Init OK
[+261ms] [2026-10-26 08:28:27][APP] ADC init: OK
[+261ms] [2026-10-26 08:28:27][APP] ADC input layer init: OK
[+271ms] [2026-10-26 08:28:27][APP] phasor layer init: OK (inst=5)
[+271ms] [2026-10-26 08:28:27][APP] freq layer init: OK
[+282ms] [2026-10-26 08:28:27][CFG] register: section 'adc_cal' (9 keys)
[+282ms] [2026-10-26 08:28:27][CFG] register: section 'adc_cal_ofs' (8 keys)
[+292ms] [2026-10-26 08:28:27][APP] adc cal init: OK (k_q16 tpafe=10000000 stm32=52800000)
[+302ms] [2026-10-26 08:28:27][CFG] register: section 'run_par' (9 keys)
[+302ms] [2026-10-26 08:28:27][APP] run par init: OK (db9 k/b via adc_cal, evt=1<<8)
[+313ms] [2026-10-26 08:28:27][APP] protection init: OK (set=40 elm=9)
[+323ms] [2026-10-26 08:28:27][APP] SD2506 ID: 2512153425482405
[+323ms] [2026-10-26 08:28:27][APP] SD2506 time: 2026-10-26 08:28:27 (week 1)
[+333ms] [2026-10-26 08:28:27][APP] SD2506 temp: 25 C
[+333ms] [2026-10-26 08:28:27][APP] SD2506 battery: 3.12 V
[+344ms] [2026-10-26 08:28:27][APP] App init OK
[+344ms] [2026-10-26 08:28:27][NAND_FTL] Initializing NAND FTL...
[+365ms] [2026-10-26 08:28:27][PROT] uncalibrated -> protection blocked (UA/UN/IA VALID not all set)
[+450ms] [2026-10-26 08:28:27][NAND_FTL] Map resumed: 14094/97504 sectors used
[+450ms] [2026-10-26 08:28:27][NAND_FTL] Map head=48672 tail=1651 epoch=7
[+461ms] [2026-10-26 08:28:27][NAND_FTL] NAND FTL ready (capacity: 97504 pages = 190 MB)
[+534ms] [2026-10-26 08:28:27] [FS] FATFS mounted
[+607ms] [2026-10-26 08:28:27][SYSLOG] runlog boot entry: power on
[+607ms] [2026-10-26 08:28:27][CFG] register: section 'network' (4 keys)
[+607ms] [2026-10-26 08:28:27][CFG] register: section 'ftp' (3 keys)
[+617ms] [2026-10-26 08:28:27][CFG] load: OK (957B, heap free 16552B)
[+628ms] [2026-10-26 08:28:27][NET_CFG] load: OK ip=192.168.1.100
[+638ms] [2026-10-26 08:28:27] [CFG] prot set loaded (/prot_set.bin)
[+700ms] [2026-10-26 08:28:27][ADC_TASK] first: UA=11428 UB=1082 UC=890 UN=11454 IA=11451 IB=1001 IC=1010 IN=936 T=962
[+710ms] [2026-10-26 08:28:27][ADC_TASK] phasor(first) C01-IA-F1: Re=0 Im=0 rms=0 (x0.1)
[+710ms] [2026-10-26 08:28:27][ADC_TASK] phasor(first) C02-UA-F1: Re=0 Im=0 rms=0 (x0.1)
[+720ms] [2026-10-26 08:28:27][ADC_TASK] phasor(first) C03-UN-F1: Re=0 Im=0 rms=0 (x0.1)
[+731ms] [2026-10-26 08:28:27][ADC_TASK] phasor(first) C04-IA-F2: Re=0 Im=0 rms=0 (x0.1)
[+731ms] [2026-10-26 08:28:27][ADC_TASK] phasor(first) C05-IA-F5: Re=0 Im=0 rms=0 (x0.1)
[+741ms] [2026-10-26 08:28:27][ADC_TASK] freq(first): f=0 valid=0 (x0.01)
[+751ms] [2026-10-26 08:28:27][NET_TASK] === Network Init ===
[+751ms] [2026-10-26 08:28:27][PROT] protect task start: cycle=20ms elm=9
[+751ms] [2026-10-26 08:28:27][NET] ch395f ver=0x4A fun_para=0x08
[+762ms] [2026-10-26 08:28:27][NET_TASK] net init: OK
[+772ms] [2026-10-26 08:28:27][NET_TASK] MAC: 3C:AB:72:53:2B:12
[+772ms] [2026-10-26 08:28:27][NET_TASK] IP_INF: IP=192.168.1.100 GW=192.168.1.1 MASK=255.255.255.0
[+782ms] MISS start snap=0x000001E7 req=0x000001F7 t=886
[+782ms] [2026-10-26 08:28:27][WD] [WD] armed: timeout ~2498ms (worst ~1701ms), miss_tol=800ms
[+824ms] [2026-10-26 08:28:27][UI_TASK] UI task: started, wait net ready
[+2700ms] [2026-10-26 08:28:29][NET_TASK] PHY: 100M FULL
[+2711ms] [2026-10-26 08:28:29][NET_TASK] netTask: started (single-socket mode)
[+2752ms] [2026-10-26 08:28:29] [FTP] using factory default password
[+2783ms] [2026-10-26 08:28:29][TIME_SYNC] time_sync: TCP listen on :8888 (sock=0)
[+2814ms] [2026-10-26 08:28:29][I104] i104: listening on 2404
[+2814ms] MISS start snap=0x000001E7 req=0x000001F7 t=2923
[+2825ms] [PROF] t=2928 uic=0 uip=0 uipn=0 uil=0 uiw=0 uis=0 uisn=0 adc=2477 adcm=2155 adcn=0 gl=0
[+2825ms] [PROF2] t=2928 defd=130939 defs=35408 netp=1994 netn=0 adcp=11 adcq=0 gl=0
[+2835ms] [2026-10-26 08:28:29] [FTP] waiting for connection...
[+2846ms] [2026-10-26 08:28:29][UI_TASK] UI task: net ready, init port
[+2846ms] [2026-10-26 08:28:29][UI_TASK] UI task: ui_port_init enter
[+2856ms] [2026-10-26 08:28:29][UI_PORT] theme: mono dark_bg=true applied
[+2867ms] [2026-10-26 08:28:29][UI_TASK] UI port init: OK
[+2867ms] [2026-10-26 08:28:29][UI_TASK] UI task: ui_menu_init enter
[+2877ms] [2026-10-26 08:28:29][UI_MENU] menu build start: total=15136 free=12692 big=12692
[+2887ms] [2026-10-26 08:28:29][UI_MENU_VIEW] view init: root frame w=66 h=107
[+2887ms] [2026-10-26 08:28:29][UI_MENU] menu build done: total=15020 free=11828 big=11816 used=3192
[+2898ms] [2026-10-26 08:28:29][UI_TASK] UI menu init: OK
[+2908ms] [2026-10-26 08:28:29][UI_STANDBY] standby: ready (idle=60000ms)
[+2908ms] [2026-10-26 08:28:29][UI_TASK] UI standby: ready (idle=60s)
[+2960ms] [2026-10-26 08:28:29][UI_TASK] UI net sink: started (port 7003)
[+4917ms] [PROF] t=5020 uic=176 uip=22044 uipn=1839 uil=11000 uiw=12134 uis=1184 uisn=0 adc=4568 adcm=2155 adcn=0 gl=0
[+4932ms] [PROF2] t=5020 defd=130939 defs=35408 netp=2110 netn=0 adcp=11 adcq=0 gl=0
[+5380ms] [2026-10-26 08:28:32] [STACK] default peak_used=2160/5120 free_min=2960 (57%)
[+5390ms] [2026-10-26 08:28:32] [STACK] net peak_used=1048/3840 free_min=2792 (72%)
[+5401ms] [2026-10-26 08:28:32] [STACK] ftp peak_used=740/4096 free_min=3356 (81%)
[+5401ms] [2026-10-26 08:28:32] [STACK] ui peak_used=4088/16384 free_min=12296 (75%)
[+5411ms] [2026-10-26 08:28:32] [STACK] timesync peak_used=616/2560 free_min=1944 (75%)
[+5421ms] [2026-10-26 08:28:32] [STACK] adc peak_used=1000/2560 free_min=1560 (60%)
[+5421ms] [2026-10-26 08:28:32] [STACK] iec104 peak_used=540/2560 free_min=2020 (78%)
[+5432ms] [2026-10-26 08:28:32] [STACK] protect peak_used=492/2048 free_min=1556 (75%)
[+5442ms] [2026-10-26 08:28:32] [STACK] heap free=15624 min_ever=8464
[+6947ms] [PROF] t=7050 uic=354 uip=73720 uipn=3839 uil=10999 uiw=12134 uis=1184 uisn=0 adc=6598 adcm=2155 adcn=0 gl=0
[+6957ms] [PROF2] t=7050 defd=130939 defs=35408 netp=2110 netn=0 adcp=11 adcq=0 gl=0
[+8960ms] [PROF] t=9068 uic=536 uip=73720 uipn=9838 uil=11000 uiw=12134 uis=1199 uisn=0 adc=8616 adcm=2155 adcn=0 gl=0
[+8970ms] [PROF2] t=9068 defd=130939 defs=35408 netp=2110 netn=0 adcp=11 adcq=0 gl=0
[+10350ms] [2026-10-26 08:28:37][ADC_TASK] frames=10001 idle=0 skip=38 seq=10006 frst_err=0 ring=9963 adc1_rc=0 adc1_err=0 adc1_seq=10004 adc1_gap=40 adc1_hw=0 tgap=1
[+10360ms] [2026-10-26 08:28:37][ADC_TASK] phasor(hb) C01-IA-F1: Re=0 Im=0 rms=0 (x0.1)
[+10370ms] [2026-10-26 08:28:37][ADC_TASK] phasor(hb) C02-UA-F1: Re=0 Im=0 rms=0 (x0.1)
[+10370ms] [2026-10-26 08:28:37][ADC_TASK] phasor(hb) C03-UN-F1: Re=0 Im=0 rms=0 (x0.1)
[+10381ms] [2026-10-26 08:28:37][ADC_TASK] phasor(hb) C04-IA-F2: Re=0 Im=0 rms=0 (x0.1)
[+10391ms] [2026-10-26 08:28:37][ADC_TASK] phasor(hb) C05-IA-F5: Re=0 Im=0 rms=0 (x0.1)
[+10402ms] [2026-10-26 08:28:37][ADC_TASK] freq(hb): f=0 valid=0 (x0.01)
[+10402ms] [2026-10-26 08:28:37][ADC_TASK] cal: ua_mv=1743 un_mv=1747 ia_mv=1747 vl=0x00 cl=0xe6 rail=0x000 edge=0x000
[+10412ms] [2026-10-26 08:28:37][ADC_TASK] meas: seq=50 v=1 ua_mv=0 un_mv=0 ia_mv=0 f=0 fv=0
[+10969ms] [PROF] t=11074 uic=711 uip=75494 uipn=10839 uil=10924 uiw=12134 uis=1199 uisn=0 adc=10621 adcm=2786 adcn=0 gl=0
[+10980ms] [PROF2] t=11074 defd=130939 defs=35408 netp=4013 netn=0 adcp=11 adcq=0 gl=0
[+12983ms] [PROF] t=13092 uic=893 uip=75494 uipn=9839 uil=10999 uiw=12134 uis=1199 uisn=0 adc=12639 adcm=2786 adcn=0 gl=0
[+12993ms] [PROF2] t=13092 defd=130939 defs=35408 netp=4013 netn=0 adcp=11 adcq=0 gl=0
[+15004ms] [PROF] t=15110 uic=1075 uip=75494 uipn=9839 uil=10999 uiw=12134 uis=1199 uisn=0 adc=14657 adcm=2786 adcn=0 gl=0
[+15014ms] [PROF2] t=15110 defd=130939 defs=35408 netp=4013 netn=0 adcp=11 adcq=0 gl=0
[+17027ms] [PROF] t=17128 uic=1257 uip=75494 uipn=9838 uil=11000 uiw=12134 uis=1199 uisn=0 adc=16675 adcm=2786 adcn=0 gl=0
[+17027ms] [PROF2] t=17128 defd=130939 defs=35408 netp=4013 netn=0 adcp=11 adcq=0 gl=0
[+19043ms] [PROF] t=19146 uic=1439 uip=75494 uipn=9839 uil=10998 uiw=12134 uis=1199 uisn=0 adc=18693 adcm=2786 adcn=0 gl=0
[+19054ms] [PROF2] t=19146 defd=130939 defs=35408 netp=4013 netn=0 adcp=11 adcq=0 gl=0
[+20351ms] [2026-10-26 08:28:47][ADC_TASK] frames=20000 idle=0 skip=54 seq=20006 frst_err=0 ring=19946 adc1_rc=0 adc1_err=0 adc1_seq=20004 adc1_gap=57 adc1_hw=0 tgap=2
[+20361ms] [2026-10-26 08:28:47][ADC_TASK] phasor(hb) C01-IA-F1: Re=0 Im=0 rms=0 (x0.1)
[+20372ms] [2026-10-26 08:28:47][ADC_TASK] phasor(hb) C02-UA-F1: Re=0 Im=0 rms=0 (x0.1)
[+20372ms] [2026-10-26 08:28:47][ADC_TASK] phasor(hb) C03-UN-F1: Re=0 Im=0 rms=0 (x0.1)
[+20382ms] [2026-10-26 08:28:47][ADC_TASK] phasor(hb) C04-IA-F2: Re=0 Im=0 rms=0 (x0.1)
[+20392ms] [2026-10-26 08:28:47][ADC_TASK] phasor(hb) C05-IA-F5: Re=0 Im=0 rms=0 (x0.1)
[+20392ms] [2026-10-26 08:28:47][ADC_TASK] freq(hb): f=0 valid=0 (x0.01)
[+20403ms] [2026-10-26 08:28:47][ADC_TASK] cal: ua_mv=1743 un_mv=1747 ia_mv=1747 vl=0x00 cl=0xe6 rail=0x000 edge=0x000
[+20413ms] [2026-10-26 08:28:47][ADC_TASK] meas: seq=100 v=1 ua_mv=0 un_mv=0 ia_mv=0 f=0 fv=0
[+21074ms] [PROF] t=21174 uic=1617 uip=75494 uipn=840 uil=10998 uiw=12134 uis=1199 uisn=584 adc=20720 adcm=2804 adcn=0 gl=0
[+21074ms] [PROF2] t=21174 defd=130939 defs=35408 netp=4029 netn=0 adcp=11 adcq=0 gl=0
[+23084ms] [PROF] t=23192 uic=1798 uip=75494 uipn=9839 uil=10999 uiw=18756 uis=18501 uisn=0 adc=22738 adcm=2804 adcn=0 gl=0
[+23094ms] [PROF2] t=23192 defd=130939 defs=35408 netp=4029 netn=0 adcp=11 adcq=0 gl=0
[+25102ms] [PROF] t=25210 uic=1980 uip=75494 uipn=9838 uil=11000 uiw=18756 uis=18501 uisn=0 adc=24756 adcm=2804 adcn=0 gl=0
[+25112ms] [PROF2] t=25210 defd=130939 defs=35408 netp=4029 netn=0 adcp=11 adcq=0 gl=0
[+27123ms] [PROF] t=27228 uic=2162 uip=75494 uipn=9839 uil=10998 uiw=18756 uis=18501 uisn=0 adc=26774 adcm=2804 adcn=0 gl=0
[+27133ms] [PROF2] t=27228 defd=130939 defs=35408 netp=4029 netn=0 adcp=11 adcq=0 gl=0
[+29146ms] [PROF] t=29246 uic=2344 uip=75494 uipn=9839 uil=11000 uiw=18756 uis=18501 uisn=0 adc=28792 adcm=2804 adcn=0 gl=0
[+29146ms] [PROF2] t=29246 defd=130939 defs=35408 netp=4029 netn=0 adcp=11 adcq=0 gl=0
