Review the application logs

[dido18]

Review the verbose configuration to set verbose output log.

• Check that the correct log level and messages are used throughout the application
• Disable the GIN logging at startup

[dido18]

Upload a sketch and see the difference with and without verbose

Edit the file config.ini and setting v = false or v = true

With verbose=false

2025/04/02 12:08:41 stdout: time="2025-04-02T12:08:41+02:00" level=info msg="additional config file not found in config.ini"
2025/04/02 12:08:41 stdout: time="2025-04-02T12:08:41+02:00" level=info msg="Version:x.x.x-dev"
2025/04/02 12:08:41 stdout: time="2025-04-02T12:08:41+02:00" level=info msg="Hostname: dido-ThinkPad-X1-Carbon-Gen-9"
2025/04/02 12:08:41 stdout: time="2025-04-02T12:08:41+02:00" level=info msg="Garbage collection is on using Standard mode, meaning we just let Golang determine when to garbage collect."
2025/04/02 12:08:41 stdout: time="2025-04-02T12:08:41+02:00" level=info msg="You specified a serial port regular expression filter: usb|acm|com\n"
2025/04/02 12:08:41 stdout: time="2025-04-02T12:08:41+02:00" level=info msg="You can enter verbose mode to see all logging by setting the v key in the configuration file to true."
2025/04/02 12:08:41 stdout: [GIN-debug] [WARNING] Running in "debug" mode. Switch to "release" mode in production.
2025/04/02 12:08:41 stdout:  - using env:       export GIN_MODE=release
2025/04/02 12:08:41 stdout:  - using code:      gin.SetMode(gin.ReleaseMode)
2025/04/02 12:08:41 stdout: 
2025/04/02 12:08:41 stdout: [GIN-debug] GET    /                         --> main.homeHandler (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] POST   /upload                   --> main.loop.uploadHandler.func4 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] GET    /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] POST   /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] WS     /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] WSS    /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] GET    /info                     --> main.infoHandler (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] POST   /pause                    --> main.pauseHandler (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] POST   /update                   --> main.updateHandler (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] GET    /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] POST   /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] PUT    /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] PATCH  /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] HEAD   /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] OPTIONS /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] DELETE /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] CONNECT /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] TRACE  /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:08:41 stdout: [GIN-debug] [WARNING] You trusted all proxies, this is NOT safe. We recommend you to set a value.
2025/04/02 12:08:41 stdout: Please check https://pkg.go.dev/github.com/gin-gonic/gin#readme-don-t-trust-all-proxies for details.
2025/04/02 12:08:41 stdout: [GIN-debug] Listening and serving HTTP on 127.0.0.1:8991
2025/04/02 12:08:42 stdout: [GIN-debug] [WARNING] Headers were already written. Wanted to override status code 200 with 400
2025/04/02 12:08:42 stderr: time="2025-04-02T12:08:42+02:00" level=info msg=" id=nc-ag9L3 req=HEAD /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:08:42 stderr: time="2025-04-02T12:08:42+02:00" level=info msg=" id=nc-ag9L3 status=200 bytes=0 time=44.138µs"
2025/04/02 12:08:43 stdout: [GIN-debug] [WARNING] Headers were already written. Wanted to override status code 200 with 400
2025/04/02 12:08:43 stderr: time="2025-04-02T12:08:43+02:00" level=info msg=" id=WyqgP11i req=HEAD /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:08:43 stderr: time="2025-04-02T12:08:43+02:00" level=info msg=" id=WyqgP11i status=200 bytes=0 time=26.103µs"
2025/04/02 12:09:12 stderr: time="2025-04-02T12:09:12+02:00" level=info msg=" id=FR5uwauG req=POST /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:09:12 stderr: time="2025-04-02T12:09:12+02:00" level=info msg=" id=FR5uwauG status=200 bytes=16 time=372.174647ms"
2025/04/02 12:13:13 stderr: time="2025-04-02T12:13:13+02:00" level=info msg=" id=zz_7VE3i req=HEAD /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:13:13 stderr: time="2025-04-02T12:13:13+02:00" level=info msg=" id=zz_7VE3i status=200 bytes=0 time=50.033µs

With verbose=true

2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="using config from default: /home/dido/.config/ArduinoCreateAgent/config.ini"
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="additional config file not found in config.ini"
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="Version:x.x.x-dev"
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="Hostname: dido-ThinkPad-X1-Carbon-Gen-9"
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="Garbage collection is on using Standard mode, meaning we just let Golang determine when to garbage collect."
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="You specified a serial port regular expression filter: usb|acm|com\n"
2025/04/02 12:19:28 stdout: [GIN-debug] [WARNING] Running in "debug" mode. Switch to "release" mode in production.
2025/04/02 12:19:28 stdout:  - using env:       export GIN_MODE=release
2025/04/02 12:19:28 stdout:  - using code:      gin.SetMode(gin.ReleaseMode)
2025/04/02 12:19:28 stdout: 
2025/04/02 12:19:28 stdout: [GIN-debug] GET    /                         --> main.homeHandler (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] POST   /upload                   --> main.loop.uploadHandler.func4 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] GET    /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] POST   /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] WS     /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] WSS    /socket.io/               --> main.(*WsServer).ServeHTTP-fm (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] GET    /info                     --> main.infoHandler (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] POST   /pause                    --> main.pauseHandler (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] POST   /update                   --> main.updateHandler (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] GET    /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] POST   /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] PUT    /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] PATCH  /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] HEAD   /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] OPTIONS /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] DELETE /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] CONNECT /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] TRACE  /v2/*path                 --> main.loop.WrapH.func5 (2 handlers)
2025/04/02 12:19:28 stdout: [GIN-debug] [WARNING] You trusted all proxies, this is NOT safe. We recommend you to set a value.
2025/04/02 12:19:28 stdout: Please check https://pkg.go.dev/github.com/gin-gonic/gin#readme-don-t-trust-all-proxies for details.
2025/04/02 12:19:28 stdout: [GIN-debug] Listening and serving HTTP on 127.0.0.1:8991
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=error msg="Could not find HTTPS certificate. Using plain HTTP only."
2025/04/02 12:19:28 stdout: time="2025-04-02T12:19:28+02:00" level=info msg="Serial discovery started, watching for events"
2025/04/02 12:19:29 stdout: [GIN-debug] [WARNING] Headers were already written. Wanted to override status code 200 with 400
2025/04/02 12:19:29 stderr: time="2025-04-02T12:19:29+02:00" level=info msg=" id=eOYXMqVO req=HEAD /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:19:29 stderr: time="2025-04-02T12:19:29+02:00" level=info msg=" id=eOYXMqVO status=200 bytes=0 time=56.859µs"
2025/04/02 12:19:30 stdout: [GIN-debug] [WARNING] Headers were already written. Wanted to override status code 200 with 400
2025/04/02 12:19:30 stderr: time="2025-04-02T12:19:30+02:00" level=info msg=" id=DoiUBSoQ req=HEAD /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:19:30 stderr: time="2025-04-02T12:19:30+02:00" level=info msg=" id=DoiUBSoQ status=200 bytes=0 time=47.564µs"
2025/04/02 12:19:53 stderr: time="2025-04-02T12:19:53+02:00" level=info msg=" id=PCMxaA46 req=POST /v2/pkgs/tools/installed from=127.0.0.1"
2025/04/02 12:19:53 stderr: time="2025-04-02T12:19:53+02:00" level=info msg=" id=PCMxaA46 status=200 bytes=16 time=350.418377ms"
2025/04/02 12:19:53 stdout: time="2025-04-02T12:19:53+02:00" level=info msg="/dev/ttyACM0 arduino:samd:mkrwifi1010  \"{runtime.tools.bossac-1.7.0-arduino3.path}/bossac\" -i -d --port={serial.port.file} -U true -i -e -w -v \"{build.path}/{build.project_name}.bin\" -R {Use1200bpsTouch:true WaitForUploadPort:true Network:false} mkrwifi-weather_dec06a.bin"
2025/04/02 12:19:53 stdout: time="2025-04-02T12:19:53+02:00" level=info msg="Restarting in bootloader mode"
2025/04/02 12:19:57 stdout: time="2025-04-02T12:19:57+02:00" level=info msg="Flashing with command:/home/dido/.arduino-create/arduino/bossac/1.7.0-arduino3/bossac -i -d --port=ttyACM0 -U true -i -e -w -v /tmp/arduino-create-agent1465199934/mkrwifi-weather_dec06a.bin -R"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Set binary mode"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0)=0x20007ffc"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0xe000ed00)=0x410cc601"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41002018)=0x10010305"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="version()=v2.0 [Arduino:XYZ] Mar 19 2018 09:45:14"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="chipId=0x10010005"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Connected at 921600 baud"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0)=0x20007ffc"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0xe000ed00)=0x410cc601"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41002018)=0x10010305"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Atmel SMART device 0x10010005 found"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="write(addr=0x20004000,size=0x34)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeWord(addr=0x20004030,value=0x10)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeWord(addr=0x20004020,value=0x20008000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Device       : ATSAMD21G18A"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0)=0x20007ffc"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0xe000ed00)=0x410cc601"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41002018)=0x10010305"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Chip ID      : 10010005"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="version()=v2.0 [Arduino:XYZ] Mar 19 2018 09:45:14"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Version      : v2.0 [Arduino:XYZ] Mar 19 2018 09:45:14"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Address      : 8192"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Pages        : 3968"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Page Size    : 64 bytes"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Total Size   : 248KB"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Planes       : 1"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Lock Regions : 16"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Locked       : readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004020)=0xffff"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg=none
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x41004018)=0"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Security     : false"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Boot Flash   : true"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x40000834)=0x7000a"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="BOD          : true"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="readWord(addr=0x40000834)=0x7000a"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="BOR          : true"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Arduino      : FAST_CHIP_ERASE"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Arduino      : FAST_MULTI_PAGE_WRITE"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Arduino      : CAN_CHECKSUM_MEMORY_BUFFER"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Erase flash"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="chipErase(addr=0x2000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="done in 0.839 seconds"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="Write 179088 bytes to flash (2799 pages)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x2000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[                              ] 2% (64/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x3000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=                             ] 4% (128/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x4000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[==                            ] 6% (192/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x5000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[==                            ] 9% (256/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x6000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[===                           ] 11% (320/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x7000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[====                          ] 13% (384/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x8000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[====                          ] 16% (448/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x9000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=====                         ] 18% (512/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0xa000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[======                        ] 20% (576/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0xb000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[======                        ] 22% (640/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0xc000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=======                       ] 25% (704/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0xd000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[========                      ] 27% (768/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0xe000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[========                      ] 29% (832/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0xf000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=========                     ] 32% (896/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x10000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[==========                    ] 34% (960/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x11000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[==========                    ] 36% (1024/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x12000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[===========                   ] 38% (1088/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x13000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[============                  ] 41% (1152/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x14000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=============                 ] 43% (1216/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x15000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=============                 ] 45% (1280/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x16000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[==============                ] 48% (1344/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x17000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[===============               ] 50% (1408/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x18000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[===============               ] 52% (1472/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x19000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[================              ] 54% (1536/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x1a000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=================             ] 57% (1600/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x1b000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=================             ] 59% (1664/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x1c000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[==================            ] 61% (1728/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x1d000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[===================           ] 64% (1792/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x1e000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[===================           ] 66% (1856/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x1f000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[====================          ] 68% (1920/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x20000, size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="\r[=====================         ] 70% (1984/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:19:59 stdout: time="2025-04-02T12:19:59+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x21000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[=====================         ] 73% (2048/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x22000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[======================        ] 75% (2112/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x23000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[=======================       ] 77% (2176/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x24000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[========================      ] 80% (2240/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x25000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[========================      ] 82% (2304/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x26000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[=========================     ] 84% (2368/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x27000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[==========================    ] 86% (2432/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x28000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[==========================    ] 89% (2496/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x29000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[===========================   ] 91% (2560/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x2a000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[============================  ] 93% (2624/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x2b000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[============================  ] 96% (2688/2799 pages)write(addr=0x20005000,size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x2c000, size=0x1000)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[============================= ] 98% (2752/2799 pages)write(addr=0x20005000,size=0xbc0)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="writeBuffer(scr_addr=0x20005000, dst_addr=0x2d000, size=0xbc0)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="\r[==============================] 100% (2799/2799 pages)"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="done in 1.013 seconds"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="Verify 179088 bytes of flash with checksum."
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x2000, size=0x1000) = 21e5"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x3000, size=0x1000) = a0b4"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x4000, size=0x1000) = d4f2"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x5000, size=0x1000) = a1c6"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x6000, size=0x1000) = 4a5a"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x7000, size=0x1000) = e807"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x8000, size=0x1000) = d19f"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x9000, size=0x1000) = e912"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0xa000, size=0x1000) = 5f59"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0xb000, size=0x1000) = fd1c"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0xc000, size=0x1000) = b194"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0xd000, size=0x1000) = 61ac"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0xe000, size=0x1000) = 3c02"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0xf000, size=0x1000) = d68c"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x10000, size=0x1000) = 3ed7"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x11000, size=0x1000) = 17b3"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x12000, size=0x1000) = 80d5"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x13000, size=0x1000) = 3dc2"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x14000, size=0x1000) = b98d"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x15000, size=0x1000) = 51b1"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x16000, size=0x1000) = d4a2"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x17000, size=0x1000) = d188"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x18000, size=0x1000) = a509"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x19000, size=0x1000) = e0a7"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x1a000, size=0x1000) = 65b8"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x1b000, size=0x1000) = 6040"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x1c000, size=0x1000) = caec"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x1d000, size=0x1000) = 1d63"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x1e000, size=0x1000) = 98d3"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x1f000, size=0x1000) = 8c33"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x20000, size=0x1000) = 5add"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x21000, size=0x1000) = d31f"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x22000, size=0x1000) = 3f5a"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x23000, size=0x1000) = 390c"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x24000, size=0x1000) = 7155"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg="checksumBuffer(start_addr=0x25000, size=0x1000) = f8aa"
2025/04/02 12:20:00 stdout: time="2025-04-02T12:20:00+02:00" level=info msg=checks