Bug report logs 92a845096c7840be84d6b69d3206bd19.log

logs/92a845096c7840be84d6b69d3206bd19.log

@@ -0,0 +1,200 @@
+2026-05-12 11:26:51,385 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:26:52,485 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-05-12 11:26:53,415 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:26:53,415 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:26:53,416 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:26:53,416 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:01,460 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:06,021 DEBUG [backend.app.api.routes.printers] [1c284483] API returning ams_mapping: [], ams_extruder_map: {'0': 0}
+2026-05-12 11:27:06,021 DEBUG [backend.app.api.routes.printers] [1c284483] Using tray_now directly as global ID: 255
+2026-05-12 11:27:06,024 DEBUG [backend.app.api.routes.printers] [0af71bc6] API returning ams_mapping: [], ams_extruder_map: {'0': 0}
+2026-05-12 11:27:06,024 DEBUG [backend.app.api.routes.printers] [0af71bc6] Using tray_now directly as global ID: 255
+2026-05-12 11:27:07,495 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:07,768 INFO [backend.app.api.routes.archives] [ada931b1] Dispatched reprint archive 7 for printer 1 (dispatch_job_id=20, dispatch_position=1)
+2026-05-12 11:27:07,769 INFO [uvicorn.access] [-] [IP]:55050 - "POST /api/v1/archives/7/reprint?printer_id=1 HTTP/1.1" 200
+2026-05-12 11:27:07,779 DEBUG [backend.app.services.bambu_ftp] [-] FTP connecting to [IP]:990 (timeout=30.0s, model=[PRINTER], prot_c=False)
+2026-05-12 11:27:08,526 DEBUG [backend.app.services.bambu_ftp] [-] FTP connected, logging in as bblp
+2026-05-12 11:27:08,540 DEBUG [backend.app.services.bambu_ftp] [-] FTP logged in, setting prot_p (protected) and passive mode
+2026-05-12 11:27:08,566 DEBUG [backend.app.services.bambu_ftp] [-] FTP server welcome: 220 BBL-P003 FTP Server
+2026-05-12 11:27:08,566 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=[PRINTER], prot_c=False)
+2026-05-12 11:27:08,612 INFO [backend.app.services.bambu_ftp] [-] FTP connecting to [IP] for upload (model=[PRINTER], mode=prot_p, socket_timeout=30.0s)...
+2026-05-12 11:27:08,612 DEBUG [backend.app.services.bambu_ftp] [-] FTP connecting to [IP]:990 (timeout=30.0s, model=[PRINTER], prot_c=False)
+2026-05-12 11:27:09,354 DEBUG [backend.app.services.bambu_ftp] [-] FTP connected, logging in as bblp
+2026-05-12 11:27:09,378 DEBUG [backend.app.services.bambu_ftp] [-] FTP logged in, setting prot_p (protected) and passive mode
+2026-05-12 11:27:09,393 DEBUG [backend.app.services.bambu_ftp] [-] FTP server welcome: 220 BBL-P003 FTP Server
+2026-05-12 11:27:09,393 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=[PRINTER], prot_c=False)
+2026-05-12 11:27:09,393 INFO [backend.app.services.bambu_ftp] [-] FTP connected to [IP]
+2026-05-12 11:27:09,393 INFO [backend.app.services.bambu_ftp] [-] FTP uploading /app/data/archive/1/20260512_080224_3x1x1 LU - Topped Rail - MultiBin Shell/3x1x1 LU - Topped Rail - MultiBin Shell.gcode.3mf (1181379 bytes) to /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf
+2026-05-12 11:27:09,393 DEBUG [backend.app.services.bambu_ftp] [-] FTP STOR command starting for /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf
+2026-05-12 11:27:09,447 INFO [backend.app.services.bambu_ftp] [-] FTP data channel ready in 0.1s (PASV + TLS handshake)
+2026-05-12 11:27:09,456 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 65536/1181379 bytes
+2026-05-12 11:27:09,533 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 131072/1181379 bytes
+2026-05-12 11:27:09,899 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 196608/1181379 bytes
+2026-05-12 11:27:10,321 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 262144/1181379 bytes
+2026-05-12 11:27:10,675 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 327680/1181379 bytes
+2026-05-12 11:27:10,997 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 393216/1181379 bytes
+2026-05-12 11:27:11,363 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 458752/1181379 bytes
+2026-05-12 11:27:11,780 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 524288/1181379 bytes
+2026-05-12 11:27:12,089 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 589824/1181379 bytes
+2026-05-12 11:27:12,424 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 655360/1181379 bytes
+2026-05-12 11:27:12,887 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 720896/1181379 bytes
+2026-05-12 11:27:13,248 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 786432/1181379 bytes
+2026-05-12 11:27:13,575 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 851968/1181379 bytes
+2026-05-12 11:27:13,880 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 917504/1181379 bytes
+2026-05-12 11:27:14,241 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 983040/1181379 bytes
+2026-05-12 11:27:14,666 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1048576/1181379 bytes
+2026-05-12 11:27:14,962 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1114112/1181379 bytes
+2026-05-12 11:27:15,304 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1179648/1181379 bytes
+2026-05-12 11:27:15,505 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1181379/1181379 bytes
+2026-05-12 11:27:15,505 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload: final chunk reached
+2026-05-12 11:27:15,964 INFO [backend.app.services.bambu_ftp] [-] FTP STOR confirmed for /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf: 226
+2026-05-12 11:27:15,964 INFO [backend.app.services.bambu_ftp] [-] FTP upload complete: /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf (1181379 bytes in 6.6s, 176 KB/s)
+2026-05-12 11:27:15,964 INFO [backend.app.services.bambu_ftp] [-] FTP mode cached for [IP]: prot_p
+2026-05-12 11:27:15,979 INFO [backend.app.main] [-] Registered expected print: printer=1, file=3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf, archive=7, ams_mapping=[-1, -1, 3]
+2026-05-12 11:27:15,980 INFO [backend.app.services.printer_manager] [-] PRINT COMMAND: printer=1, file=3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf, caller=background_dispatch.py:540:_process_job
+2026-05-12 11:27:15,980 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Sending print command: {"print": {"sequence_id": "20000", "command": "project_file", "param": "Metadata/plate_1.gcode", "url": "ftp://3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf", "file": "3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf", "md5": "", "bed_type": "auto", "timelapse": false, "bed_leveling": true, "auto_bed_leveling": 1, "flow_cali": false, "vibration_cali": true, "layer_inspect": false, "use_ams": true, "cfg": "0", "extrude_cali_flag": 0, "extrude_cali_manual_mode": 0, "nozzle_offset_cali": 2, "subtask_name": "3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell", "profile_id": "0", "project_id": "465176264", "subtask_id": "465176264", "task_id": "465176264", "ams_mapping": [-1, -1, 3], "ams_mapping2": [{"ams_id": 255, "slot_id": 255}, {"ams_id": 255, "slot_id": 255}, {"ams_id": 0, "slot_id": 3}]}}
+2026-05-12 11:27:15,998 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: project_file
+2026-05-12 11:27:15,999 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] timelapse field: False
+2026-05-12 11:27:17,235 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:27:17,235 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:27:17,235 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:27:17,235 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:37,275 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:37,847 INFO [backend.app.api.routes.support] [f263f1cc] Log level changed to INFO
+2026-05-12 11:27:37,848 INFO [uvicorn.access] [-] [IP]:55496 - "POST /api/v1/support/debug-logging HTTP/1.1" 200
+2026-05-12 11:27:40,258 INFO [backend.app.api.routes.support] [a07cba67] Log level changed to DEBUG
+2026-05-12 11:27:40,258 INFO [uvicorn.access] [-] [IP]:55520 - "POST /api/v1/support/debug-logging HTTP/1.1" 200
+2026-05-12 11:27:41,490 INFO [backend.app.api.routes.support] [ca64374b] Generated support bundle: bambuddy-support-20260512-112741.zip
+2026-05-12 11:27:43,323 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:27:43,324 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:27:43,324 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:27:43,324 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:45,352 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:27:45,352 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:27:45,352 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:27:45,352 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:47,385 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:53,415 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:27:55,422 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:01,461 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:09,518 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:13,552 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:17,573 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:19,602 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:28:19,602 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:28:19,602 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:28:19,602 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:21,632 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:28:21,632 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:28:21,632 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:28:21,632 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:23,648 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:29,680 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:31,705 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:37,766 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:43,775 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:53,840 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:55,860 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:55,860 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -68dBm
+2026-05-12 11:28:57,879 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:28:57,879 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -69dBm
+2026-05-12 11:29:01,912 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:05,935 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:09,960 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:11,979 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:20,042 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:29:20,043 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:29:20,044 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:29:20,045 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:22,075 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:29:22,076 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:29:22,076 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:29:22,076 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:28,130 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:29:28,130 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:29:28,130 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:29:28,131 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:32,167 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:29:32,168 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:29:32,168 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:29:32,168 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:34,201 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:29:34,201 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:29:34,201 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:29:34,201 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:34,458 DEBUG [backend.app.api.routes.printers] [48d5a6a7] API returning ams_mapping: [], ams_extruder_map: {'0': 0}
+2026-05-12 11:29:34,458 DEBUG [backend.app.api.routes.printers] [48d5a6a7] Using tray_now directly as global ID: 255
+2026-05-12 11:29:34,459 DEBUG [backend.app.api.routes.printers] [c6deb1c8] API returning ams_mapping: [], ams_extruder_map: {'0': 0}
+2026-05-12 11:29:34,459 DEBUG [backend.app.api.routes.printers] [c6deb1c8] Using tray_now directly as global ID: 255
+2026-05-12 11:29:40,230 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:46,266 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:56,334 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:58,272 DEBUG [backend.app.services.bambu_mqtt] [a27d1bd1] [[SERIAL]] Requesting status update (pushall)
+2026-05-12 11:29:58,272 INFO [uvicorn.access] [-] [IP]:57132 - "POST /api/v1/bug-report/start-logging HTTP/1.1" 200
+2026-05-12 11:29:58,336 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: , subtask_name: 3x1x1 LU - Topped Rail - MultiBin Shell
+2026-05-12 11:29:58,336 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS dict fields: {'ams_exist_bits': '1', 'tray_exist_bits': 'e', 'tray_is_bbl_bits': 'e', 'tray_tar': '255', 'tray_now': '255', 'tray_pre': '255', 'tray_read_done_bits': 'e', 'tray_reading_bits': '0', 'version': 24, 'insert_flag': True, 'power_on_flag': True}
+2026-05-12 11:29:58,336 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] tray_now updated: 255
+2026-05-12 11:29:58,336 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-05-12 11:29:58,336 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-05-12 11:29:58,337 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-05-12 11:29:58,337 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_status: 0 (main=0, sub=0)
+2026-05-12 11:29:58,337 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:29:58,337 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper raw value: 5.0
+2026-05-12 11:29:58,337 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper direct value: 5.0°C (heater OFF)
+2026-05-12 11:29:58,337 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber heating calculated: target=0.0, current=5.0, heating=False, respect_local=False
+2026-05-12 11:29:58,338 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber temp updated to: 5.0, target: 0.0, heating: False
+2026-05-12 11:29:58,338 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: [{'attr': 83887360, 'code': 65543, 'action': 0, 'timestamp': 1777322830}]
+2026-05-12 11:29:58,338 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ipcam field: {'ipcam_dev': '1', 'ipcam_record': 'enable', 'timelapse': 'disable', 'resolution': '', 'tutk_server': 'disable', 'mode_bits': 3}
+2026-05-12 11:29:58,338 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -69dBm
+2026-05-12 11:29:58,338 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'node': 'chamber_light', 'mode': 'off'}]
+2026-05-12 11:29:58,339 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: , subtask: 3x1x1 LU - Topped Rail - MultiBin Shell
+2026-05-12 11:30:00,348 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:30:00,349 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -70dBm
+2026-05-12 11:30:02,494 INFO [backend.app.api.routes.archives] [5ce29ea6] Dispatched reprint archive 7 for printer 1 (dispatch_job_id=21, dispatch_position=1)
+2026-05-12 11:30:02,496 INFO [uvicorn.access] [-] [IP]:57192 - "POST /api/v1/archives/7/reprint?printer_id=1 HTTP/1.1" 200
+2026-05-12 11:30:02,520 DEBUG [backend.app.services.bambu_ftp] [-] FTP connecting to [IP]:990 (timeout=30.0s, model=[PRINTER], prot_c=False)
+2026-05-12 11:30:03,273 DEBUG [backend.app.services.bambu_ftp] [-] FTP connected, logging in as bblp
+2026-05-12 11:30:03,299 DEBUG [backend.app.services.bambu_ftp] [-] FTP logged in, setting prot_p (protected) and passive mode
+2026-05-12 11:30:03,315 DEBUG [backend.app.services.bambu_ftp] [-] FTP server welcome: 220 BBL-P003 FTP Server
+2026-05-12 11:30:03,315 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=[PRINTER], prot_c=False)
+2026-05-12 11:30:03,364 INFO [backend.app.services.bambu_ftp] [-] FTP connecting to [IP] for upload (model=[PRINTER], mode=prot_p, socket_timeout=30.0s)...
+2026-05-12 11:30:03,365 DEBUG [backend.app.services.bambu_ftp] [-] FTP connecting to [IP]:990 (timeout=30.0s, model=[PRINTER], prot_c=False)
+2026-05-12 11:30:04,120 DEBUG [backend.app.services.bambu_ftp] [-] FTP connected, logging in as bblp
+2026-05-12 11:30:04,136 DEBUG [backend.app.services.bambu_ftp] [-] FTP logged in, setting prot_p (protected) and passive mode
+2026-05-12 11:30:04,152 DEBUG [backend.app.services.bambu_ftp] [-] FTP server welcome: 220 BBL-P003 FTP Server
+2026-05-12 11:30:04,153 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=[PRINTER], prot_c=False)
+2026-05-12 11:30:04,153 INFO [backend.app.services.bambu_ftp] [-] FTP connected to [IP]
+2026-05-12 11:30:04,153 INFO [backend.app.services.bambu_ftp] [-] FTP uploading /app/data/archive/1/20260512_080224_3x1x1 LU - Topped Rail - MultiBin Shell/3x1x1 LU - Topped Rail - MultiBin Shell.gcode.3mf (1181379 bytes) to /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf
+2026-05-12 11:30:04,153 DEBUG [backend.app.services.bambu_ftp] [-] FTP STOR command starting for /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf
+2026-05-12 11:30:04,216 INFO [backend.app.services.bambu_ftp] [-] FTP data channel ready in 0.1s (PASV + TLS handshake)
+2026-05-12 11:30:04,223 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 65536/1181379 bytes
+2026-05-12 11:30:04,363 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 131072/1181379 bytes
+2026-05-12 11:30:04,643 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 196608/1181379 bytes
+2026-05-12 11:30:04,979 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 262144/1181379 bytes
+2026-05-12 11:30:05,356 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 327680/1181379 bytes
+2026-05-12 11:30:05,726 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 393216/1181379 bytes
+2026-05-12 11:30:05,990 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 458752/1181379 bytes
+2026-05-12 11:30:06,355 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 524288/1181379 bytes
+2026-05-12 11:30:06,745 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 589824/1181379 bytes
+2026-05-12 11:30:07,054 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 655360/1181379 bytes
+2026-05-12 11:30:07,381 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 720896/1181379 bytes
+2026-05-12 11:30:07,763 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 786432/1181379 bytes
+2026-05-12 11:30:08,182 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 851968/1181379 bytes
+2026-05-12 11:30:08,582 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 917504/1181379 bytes
+2026-05-12 11:30:08,849 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 983040/1181379 bytes
+2026-05-12 11:30:09,200 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1048576/1181379 bytes
+2026-05-12 11:30:09,627 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1114112/1181379 bytes
+2026-05-12 11:30:09,879 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1179648/1181379 bytes
+2026-05-12 11:30:10,074 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload progress: 1181379/1181379 bytes
+2026-05-12 11:30:10,075 DEBUG [backend.app.services.bambu_ftp] [-] FTP upload: final chunk reached
+2026-05-12 11:30:10,520 INFO [backend.app.services.bambu_ftp] [-] FTP STOR confirmed for /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf: 226
+2026-05-12 11:30:10,521 INFO [backend.app.services.bambu_ftp] [-] FTP upload complete: /3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf (1181379 bytes in 6.4s, 181 KB/s)
+2026-05-12 11:30:10,521 INFO [backend.app.services.bambu_ftp] [-] FTP mode cached for [IP]: prot_p
+2026-05-12 11:30:10,533 INFO [backend.app.main] [-] Registered expected print: printer=1, file=3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf, archive=7, ams_mapping=[-1, -1, 3]
+2026-05-12 11:30:10,534 INFO [backend.app.services.printer_manager] [-] PRINT COMMAND: printer=1, file=3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf, caller=background_dispatch.py:540:_process_job
+2026-05-12 11:30:10,534 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Sending print command: {"print": {"sequence_id": "20000", "command": "project_file", "param": "Metadata/plate_1.gcode", "url": "ftp://3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf", "file": "3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell.3mf", "md5": "", "bed_type": "auto", "timelapse": false, "bed_leveling": true, "auto_bed_leveling": 1, "flow_cali": false, "vibration_cali": true, "layer_inspect": false, "use_ams": true, "cfg": "0", "extrude_cali_flag": 0, "extrude_cali_manual_mode": 0, "nozzle_offset_cali": 2, "subtask_name": "3x1x1_LU_-_Topped_Rail_-_MultiBin_Shell", "profile_id": "0", "project_id": "465350818", "subtask_id": "465350818", "task_id": "465350818", "ams_mapping": [-1, -1, 3], "ams_mapping2": [{"ams_id": 255, "slot_id": 255}, {"ams_id": 255, "slot_id": 255}, {"ams_id": 0, "slot_id": 3}]}}
+2026-05-12 11:30:10,554 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: project_file
+2026-05-12 11:30:10,554 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] timelapse field: False
+2026-05-12 11:30:11,864 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-05-12 11:30:11,865 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -69dBm
+2026-05-12 11:30:31,898 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status