Bug report logs e03fbe3fedc940a7b3c8e3843ccaef7c.log

logs/e03fbe3fedc940a7b3c8e3843ccaef7c.log

@@ -0,0 +1,200 @@
+2026-08-26 20:59:04,561 INFO [backend.app.services.camera] [-] Successfully captured camera frame bytes: 293951 bytes
+2026-08-26 20:59:04,561 INFO [backend.app.main] [-] [SNAPSHOT] Fresh camera frame: 293951 bytes
+2026-08-26 20:59:37,519 INFO [backend.app.api.routes.camera] [8ada5986] Using RTSP protocol for H2D
+2026-08-26 20:59:37,519 INFO [backend.app.api.routes.camera] [8ada5986] Camera viewer attached to printer-1 (subscribers=1)
+2026-08-26 20:59:37,520 INFO [backend.app.api.routes.camera] [8ada5986] Starting RTSP camera stream for [IP] (stream_id=1-fanout-a6526096, model=H2D, fps=15, probesize=32, analyzeduration=0)
+2026-08-26 21:00:31,465 INFO [uvicorn.access] [-] [IP]:53738 - "POST /api/v1/auth/ws-token HTTP/1.1" 200
+2026-08-26 21:00:31,507 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting (principal=[USER])
+2026-08-26 21:00:31,512 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-08-26 21:00:31,513 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 2 printers
+2026-08-26 21:00:37,086 INFO [backend.app.api.routes.websocket] [-] WebSocket client disconnected normally
+2026-08-26 21:01:49,372 INFO [backend.app.main] [-] [SNAPSHOT] Using buffered frame for printer 1: 163608 bytes
+2026-08-26 21:01:53,108 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Tray change during print: tray=4 at layer=0
+2026-08-26 21:02:15,055 INFO [backend.app.api.routes.cloud] [f7e1fa6e] get_filament_info called with 2 IDs: ['GFL99', 'GFU03']
+2026-08-26 21:02:15,156 INFO [backend.app.api.routes.cloud] [049b625d] get_filament_info called with 4 IDs: ['GFA00', 'GFA10', 'GFB01', 'GFA12']
+2026-08-26 21:02:15,330 INFO [uvicorn.access] [-] [IP]:50596 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-08-26 21:02:15,630 INFO [uvicorn.access] [-] [IP]:50768 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-08-26 21:02:19,209 INFO [backend.app.api.routes.camera] [8ada5986] Camera viewer detached from printer-1 (subscribers=0)
+2026-08-26 21:02:19,224 INFO [backend.app.api.routes.camera] [8ada5986] Camera stream cancelled (stream_id=1-fanout-a6526096)
+2026-08-26 21:02:19,408 INFO [backend.app.api.routes.camera] [33c518bf] Shut down camera fan-out broadcaster for printer 1
+2026-08-26 21:02:19,409 INFO [backend.app.api.routes.camera] [33c518bf] Stopped 0 camera stream(s) for printer 1
+2026-08-26 21:02:19,410 INFO [uvicorn.access] [-] [IP]:50768 - "POST /api/v1/printers/1/camera/stop HTTP/1.1" 200
+2026-08-26 21:02:32,597 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Tray change during print: tray=128 at layer=0
+2026-08-26 21:02:50,796 INFO [backend.app.main] [-] [SNAPSHOT] Capturing fresh frame for printer 1
+2026-08-26 21:02:50,798 INFO [backend.app.services.camera] [-] Capturing camera frame bytes from [IP] using RTSP (model: H2D)
+2026-08-26 21:02:51,047 INFO [backend.app.api.routes.camera] [28f27bce] Using RTSP protocol for H2D
+2026-08-26 21:02:51,047 INFO [backend.app.api.routes.camera] [28f27bce] Camera viewer attached to printer-1 (subscribers=1)
+2026-08-26 21:02:51,050 INFO [backend.app.api.routes.camera] [28f27bce] Starting RTSP camera stream for [IP] (stream_id=1-fanout-f8e575bf, model=H2D, fps=15, probesize=32, analyzeduration=0)
+2026-08-26 21:02:51,980 INFO [backend.app.services.camera] [-] Successfully captured camera frame bytes: 356943 bytes
+2026-08-26 21:02:51,980 INFO [backend.app.main] [-] [SNAPSHOT] Fresh camera frame: 356943 bytes
+2026-08-26 21:02:56,218 INFO [backend.app.api.routes.camera] [28f27bce] Camera viewer detached from printer-1 (subscribers=0)
+2026-08-26 21:02:56,227 INFO [backend.app.api.routes.camera] [28f27bce] Camera stream cancelled (stream_id=1-fanout-f8e575bf)
+2026-08-26 21:02:56,275 INFO [backend.app.api.routes.camera] [cd62120e] Shut down camera fan-out broadcaster for printer 1
+2026-08-26 21:02:56,275 INFO [backend.app.api.routes.camera] [cd62120e] Stopped 0 camera stream(s) for printer 1
+2026-08-26 21:02:56,276 INFO [uvicorn.access] [-] [IP]:49096 - "POST /api/v1/printers/1/camera/stop HTTP/1.1" 200
+2026-08-26 21:02:57,168 INFO [backend.app.main] [-] [SNAPSHOT] Capturing fresh frame for printer 1
+2026-08-26 21:02:57,169 INFO [backend.app.services.camera] [-] Capturing camera frame bytes from [IP] using RTSP (model: H2D)
+2026-08-26 21:02:58,354 INFO [backend.app.services.camera] [-] Successfully captured camera frame bytes: 353960 bytes
+2026-08-26 21:02:58,354 INFO [backend.app.main] [-] [SNAPSHOT] Fresh camera frame: 353960 bytes
+2026-08-26 21:03:04,621 INFO [backend.app.services.bambu_mqtt] [bc72d57c] [[SERIAL]] Requesting K-profiles for nozzle_diameter=0.4 (attempt 1/3, seq_id=37)
+2026-08-26 21:03:04,766 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] K-profile response: nozzle=0.4, seq_id=37, 0 profiles, matched=True
+2026-08-26 21:03:04,766 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Got 0 K-profiles for nozzle=0.4
+2026-08-26 21:03:04,768 INFO [backend.app.services.bambu_mqtt] [bc72d57c] [[SERIAL]] Got 0 K-profiles for nozzle=0.4 on attempt 1
+2026-08-26 21:03:04,782 INFO [backend.app.services.bambu_mqtt] [391f23c3] [[SERIAL]] Requesting K-profiles for nozzle_diameter=0.4 (attempt 1/3, seq_id=22)
+2026-08-26 21:03:04,795 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] K-profile response: nozzle=0.4, seq_id=22, 0 profiles, matched=True
+2026-08-26 21:03:04,795 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Got 0 K-profiles for nozzle=0.4
+2026-08-26 21:03:04,796 INFO [backend.app.services.bambu_mqtt] [391f23c3] [[SERIAL]] Got 0 K-profiles for nozzle=0.4 on attempt 1
+2026-08-26 21:03:15,296 INFO [backend.app.main] [-] Recorded 4 AMS sensor history entries
+2026-08-26 21:03:38,651 INFO [backend.app.api.routes.websocket] [-] WebSocket connect refused: no token (auth enabled)
+2026-08-26 21:03:39,370 INFO [backend.app.api.routes.support] [6df61bfc] Log level changed to DEBUG
+2026-08-26 21:03:39,370 INFO [backend.app.api.routes.bug_report] [6df61bfc] Bug report: enabled debug logging
+2026-08-26 21:03:39,370 DEBUG [backend.app.services.bambu_mqtt] [6df61bfc] [[SERIAL]] Requesting status update (pushall)
+2026-08-26 21:03:39,370 DEBUG [backend.app.services.bambu_mqtt] [6df61bfc] [[SERIAL]] Requesting status update (pushall)
+2026-08-26 21:03:39,372 INFO [uvicorn.access] [-] [IP]:44508 - "POST /api/v1/bug-report/start-logging HTTP/1.1" 200
+2026-08-26 21:03:39,385 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:39,385 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:39,385 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:39,386 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:39,386 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS dict fields: {'ams_exist_bits': '13', 'ams_exist_bits_raw': '13', 'cali_id': 255, 'cali_stat': 0, 'insert_flag': True, 'power_on_flag': False, 'tray_exist_bits': '100b9', 'tray_hall_out_bits': '10000', 'tray_is_bbl_bits': '100b9', 'tray_now': '0', 'tray_pre': '0', 'tray_read_done_bits': '100b9', 'tray_reading_bits': '0', 'tray_tar': '0', 'unbind_ams_stat': 0, 'version': 13820}
+2026-08-26 21:03:39,386 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] tray_now updated: 128
+2026-08-26 21:03:39,386 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 3 new units, 3 total
+2026-08-26 21:03:39,386 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x10002103 -> extruder 1
+2026-08-26 21:03:39,386 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 1 info=0x10002003 -> extruder 0
+2026-08-26 21:03:39,387 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 128 info=0x10942124 -> extruder 1
+2026-08-26 21:03:39,387 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:39,387 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_status: 768 (main=3, sub=0)
+2026-08-26 21:03:39,387 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] device.extruder.state=33042 (switch_state bits 12-14: 0)
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ctc_info keys: ['temp']
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber heating calculated: target=65.0, current=65.0, heating=False, respect_local=False
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber temp updated to: 65.0, target: 65.0, heating: False
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ipcam field: {'agora_service': 'disable', 'brtc_service': 'enable', 'bs_state': 0, 'cap_pic_enable': 'invalid', 'ipcam_dev': '1', 'ipcam_record': 'enable', 'laser_preview_res': 5, 'mode_bits': 2, 'resolution': '1080p', 'rtsp_url': 'rtsps://[IP]:322/streaming/live/1', 'timelapse': 'enable', 'tl_store_hpd_type': 2, 'tl_store_path_type': 2, 'tutk_server': 'disable'}
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -57dBm
+2026-08-26 21:03:39,388 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:39,389 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:39,389 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:39,392 INFO [backend.app.main] [-] [SNAPSHOT] Capturing fresh frame for printer 1
+2026-08-26 21:03:39,392 DEBUG [backend.app.services.camera] [-] TLS proxy for [IP]:322 listening on [IP]:45975
+2026-08-26 21:03:39,392 INFO [backend.app.services.camera] [-] Capturing camera frame bytes from [IP] using RTSP (model: H2D)
+2026-08-26 21:03:39,960 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-08-26 21:03:39,961 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS dict fields: {'ams_exist_bits': '1', 'tray_exist_bits': '1', 'tray_is_bbl_bits': '1', 'tray_tar': '255', 'tray_now': '255', 'tray_pre': '255', 'tray_read_done_bits': '1', 'tray_reading_bits': '0', 'version': 3, 'insert_flag': True, 'power_on_flag': False}
+2026-08-26 21:03:39,961 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] tray_now updated: 255
+2026-08-26 21:03:39,961 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-08-26 21:03:39,961 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x1001 -> extruder 0
+2026-08-26 21:03:39,962 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-08-26 21:03:39,962 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_status: 0 (main=0, sub=0)
+2026-08-26 21:03:39,962 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:39,962 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper raw value: 5.0
+2026-08-26 21:03:39,963 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper direct value: 5.0°C (heater OFF)
+2026-08-26 21:03:39,963 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber heating calculated: target=0.0, current=5.0, heating=False, respect_local=False
+2026-08-26 21:03:39,963 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber temp updated to: 5.0, target: 0.0, heating: False
+2026-08-26 21:03:39,963 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:39,963 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-08-26 21:03:39,963 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -35dBm
+2026-08-26 21:03:39,963 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'node': 'chamber_light', 'mode': 'on'}]
+2026-08-26 21:03:39,964 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-08-26 21:03:40,624 INFO [backend.app.services.camera] [-] Successfully captured camera frame bytes: 412558 bytes
+2026-08-26 21:03:40,624 INFO [backend.app.main] [-] [SNAPSHOT] Fresh camera frame: 412558 bytes
+2026-08-26 21:03:40,624 DEBUG [backend.app.main] [-] [FINISH-PHOTO-BANK] banked in-print frame for printer 1 at layer 1/240 (412558 bytes)
+2026-08-26 21:03:41,391 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:41,392 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:41,392 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:41,392 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:41,393 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:41,393 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:41,394 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:41,394 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:41,395 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:41,396 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:41,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:41,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:41,994 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:41,994 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -36dBm
+2026-08-26 21:03:43,027 INFO [uvicorn.access] [-] [IP]:50336 - "POST /api/v1/auth/ws-token HTTP/1.1" 200
+2026-08-26 21:03:43,067 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting (principal=[USER])
+2026-08-26 21:03:43,071 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-08-26 21:03:43,073 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 2 printers
+2026-08-26 21:03:43,254 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:43,255 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:43,255 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:43,255 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:43,256 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:43,256 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:43,257 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:43,257 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:43,258 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:43,258 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:43,259 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:43,259 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:45,456 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:45,457 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:45,457 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:45,457 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:45,458 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:45,458 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:45,459 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:45,460 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:45,460 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:45,462 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:45,463 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:45,463 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:45,470 INFO [backend.app.main] [-] [SNAPSHOT] Capturing fresh frame for printer 1
+2026-08-26 21:03:45,472 DEBUG [backend.app.services.camera] [-] TLS proxy for [IP]:322 listening on [IP]:43885
+2026-08-26 21:03:45,472 INFO [backend.app.services.camera] [-] Capturing camera frame bytes from [IP] using RTSP (model: H2D)
+2026-08-26 21:03:46,299 INFO [backend.app.api.routes.websocket] [-] WebSocket client disconnected normally
+2026-08-26 21:03:46,727 INFO [backend.app.services.camera] [-] Successfully captured camera frame bytes: 284788 bytes
+2026-08-26 21:03:46,728 INFO [backend.app.main] [-] [SNAPSHOT] Fresh camera frame: 284788 bytes
+2026-08-26 21:03:47,484 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:47,484 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:47,485 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:47,485 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:47,486 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:47,486 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:47,487 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:47,487 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:47,488 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:47,488 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:47,488 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:47,488 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:48,024 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:49,340 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:49,341 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:49,341 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:49,341 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:49,342 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:49,342 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:49,343 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:49,343 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:49,344 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:49,344 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:49,344 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:49,345 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:51,507 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:51,507 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:51,507 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:51,507 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:51,508 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:51,509 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:51,509 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:51,509 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:51,510 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:51,510 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:51,511 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:51,512 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:53,877 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'cfg': 1914295, 'first_layer_inspector': True, 'halt_print_sensitivity': 'medium', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-08-26 21:03:53,877 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'cfg', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-08-26 21:03:53,877 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] xcam cfg bitmask: 1914295 (binary: 0b111010011010110110111)
+2026-08-26 21:03:53,878 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: RUNNING, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: 3DBenchy
+2026-08-26 21:03:53,878 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 1, '1': 0, '128': 1}
+2026-08-26 21:03:53,879 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-08-26 21:03:53,879 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] info.temp encoded: 4259905 -> current=65, decoded_target=65
+2026-08-26 21:03:53,880 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-08-26 21:03:53,880 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Timelapse detected during print (from ipcam)
+2026-08-26 21:03:53,880 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'on', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}, {'mode': 'on', 'node': 'chamber_light2'}]
+2026-08-26 21:03:53,881 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [32768]
+2026-08-26 21:03:53,881 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: RUNNING -> RUNNING, file: /data/Metadata/plate_1.gcode, subtask: 3DBenchy
+2026-08-26 21:03:53,981 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: added 30s, total=218220s (60.62h)
+2026-08-26 21:03:53,989 DEBUG [backend.app.main] [-] Updated runtime for 1 printer(s)