Bug report logs 9b9734ebdfe1473b93944486e1caf224.log

logs/9b9734ebdfe1473b93944486e1caf224.log

@@ -0,0 +1,200 @@
+2026-10-16 10:23:46,994 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:46,994 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:47,231 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:47,231 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -42dBm
+2026-10-16 10:23:47,362 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Requesting firmware version info
+2026-10-16 10:23:47,362 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Sending K-profile priming request
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: , subtask_name: Extension_Cord_Cover
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS dict fields: {'ams_exist_bits': '0', 'tray_exist_bits': '0', 'tray_is_bbl_bits': '0', 'tray_tar': '255', 'tray_now': '254', 'tray_pre': '254', 'tray_read_done_bits': '0', 'tray_reading_bits': '0', 'version': 1, 'insert_flag': True, 'power_on_flag': False}
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] tray_now updated: 254
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 0 new units, 0 total
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS data changed, triggering sync callback
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] External spool (vt_tray) changed, triggering sync callback
+2026-10-16 10:23:47,397 INFO [backend.app.main] [-] [Printer 3] Broadcasting AMS change via WebSocket
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_status: 0 (main=0, sub=0)
+2026-10-16 10:23:47,397 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:47,398 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Fan fields in MQTT data: {'heatbreak_fan_speed': '0', 'cooling_fan_speed': '0', 'big_fan1_speed': '0', 'big_fan2_speed': '0', 'fan_gear': 0}
+2026-10-16 10:23:47,398 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] stg_cur changed: -1 -> 255 (Unknown stage (255))
+2026-10-16 10:23:47,398 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Unnamed print stage 255 on model P1S, entered from -1 (Unknown stage (-1)); state=FINISH progress=100.0% layer=170/170
+2026-10-16 10:23:47,398 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Temperature-related fields: {'nozzle_temper': 28.03125, 'nozzle_target_temper': 0, 'bed_temper': 25.625, 'bed_target_temper': 0, 'chamber_temper': 5}
+2026-10-16 10:23:47,399 INFO [backend.app.main] [-] [Printer 3] Broadcasting AMS change via WebSocket
+2026-10-16 10:23:47,399 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ALL print data keys (63): ['ams', 'ams_rfid_status', 'ams_status', 'bed_target_temper', 'bed_temper', 'big_fan1_speed', 'big_fan2_speed', 'cali_version', 'chamber_temper', 'command', 'cooling_fan_speed', 'fan_gear', 'filam_bak', 'flag3', 'force_upgrade', 'gcode_file', 'gcode_file_prepare_percent', 'gcode_state', 'heatbreak_fan_speed', 'hms', 'home_flag', 'hw_switch_state', 'ipcam', 'k', 'layer_num', 'lifecycle', 'lights_report', 'mc_percent', 'mc_print_line_number', 'mc_print_stage', 'mc_print_sub_stage', 'mc_remaining_time', 'mess_production_state', 'msg', 'net', 'nozzle_diameter', 'nozzle_target_temper', 'nozzle_temper', 'nozzle_type', 'online', 'print_error', 'print_type', 'profile_id', 'project_id', 'queue_est', 'queue_number', 'queue_sts', 'queue_total', 's_obj', 'sdcard', 'sequence_id', 'spd_lvl', 'spd_mag', 'stg', 'stg_cur', 'subtask_id', 'subtask_name', 'task_id', 'total_layer_num', 'upgrade_state', 'upload', 'vt_tray', 'wifi_signal']
+2026-10-16 10:23:47,399 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Nozzle/hardware fields in MQTT data: {'upgrade_state': {'sequence_id': 0, 'progress': '', 'status': 'IDLE', 'consistency_request': False, 'dis_state': 0, 'err_code': 0, 'force_upgrade': False, 'message': '0%, 0B/s', 'module': '', 'new_version_state': 0, 'cur_state_code': 0, 'idx2': 2770379387, 'new_ver_list': []}, 'nozzle_temper': 28.03125, 'nozzle_target_temper': 0, 'hw_switch_state': 1, 'force_upgrade': False, 'nozzle_diameter': '0.4', 'nozzle_type': 'stainless_steel'}
+2026-10-16 10:23:47,399 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper raw value: 5.0
+2026-10-16 10:23:47,399 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper direct value: 5.0°C (heater OFF)
+2026-10-16 10:23:47,399 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber heating calculated: target=0.0, current=5.0, heating=False, respect_local=False
+2026-10-16 10:23:47,399 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber temp updated to: 5.0, target: 0.0, heating: False
+2026-10-16 10:23:47,400 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:47,400 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ipcam field: {'ipcam_dev': '1', 'ipcam_record': 'disable', 'timelapse': 'disable', 'resolution': '', 'tutk_server': 'disable', 'mode_bits': 3}
+2026-10-16 10:23:47,400 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -35dBm
+2026-10-16 10:23:47,400 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'node': 'chamber_light', 'mode': 'off'}]
+2026-10-16 10:23:47,400 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Deferring developer mode probe (0.0s since connect, need 5s)
+2026-10-16 10:23:47,400 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: None -> FINISH, file: , subtask: Extension_Cord_Cover
+2026-10-16 10:23:47,401 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] State is FINISH but completion NOT triggered: prev=None, was_running=False, already_triggered=False, has_callback=True
+2026-10-16 10:23:47,405 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Firmware version: 01.10.00.00
+2026-10-16 10:23:47,452 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: extrusion_cali_get
+2026-10-16 10:23:47,452 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Adopted unsolicited K-profile table: nozzle=0.4, 1 profiles
+2026-10-16 10:23:47,531 INFO [uvicorn.access] [-] [IP]:54685 - "POST /api/v1/printers/3/connect HTTP/1.1" 200
+2026-10-16 10:23:47,584 INFO [backend.app.api.routes.cloud] [42260f6a] get_filament_info called with 1 IDs: ['GFG60']
+2026-10-16 10:23:47,584 INFO [uvicorn.access] [-] [IP]:59054 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-10-16 10:23:47,689 DEBUG [backend.app.api.routes.printers] [0181b991] API returning ams_mapping: [], ams_extruder_map: {}
+2026-10-16 10:23:47,689 DEBUG [backend.app.api.routes.printers] [0181b991] Using tray_now directly as global ID: 254
+2026-10-16 10:23:47,699 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:47,902 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:47,902 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:47,902 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:47,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:47,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:47,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:47,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:47,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [0]
+2026-10-16 10:23:47,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: /data/Metadata/plate_1.gcode, subtask: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:48,085 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:48,085 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:48,085 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-10-16 10:23:48,085 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:48,085 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:48,086 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:48,086 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:48,086 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:48,086 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:48,465 DEBUG [backend.app.api.routes.printers] [37f594f7] API returning ams_mapping: [], ams_extruder_map: {}
+2026-10-16 10:23:48,465 DEBUG [backend.app.api.routes.printers] [37f594f7] Using tray_now directly as global ID: 254
+2026-10-16 10:23:48,861 INFO [uvicorn.access] [-] [IP]:42526 - "POST /api/v1/spoolbuddy/devices/sb-d83add2e654b/heartbeat HTTP/1.1" 200
+2026-10-16 10:23:49,059 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:49,059 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:49,059 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:49,059 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:49,059 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:49,060 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:49,060 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:49,060 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [0]
+2026-10-16 10:23:49,060 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: /data/Metadata/plate_1.gcode, subtask: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:49,207 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:49,236 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:49,238 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:49,238 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -43dBm
+2026-10-16 10:23:49,518 DEBUG [backend.app.services.bambu_mqtt] [969dec3b] [[SERIAL]] Requesting status update (pushall)
+2026-10-16 10:23:49,518 INFO [uvicorn.access] [-] [IP]:54685 - "POST /api/v1/printers/3/refresh-status HTTP/1.1" 200
+2026-10-16 10:23:49,621 DEBUG [backend.app.api.routes.printers] [8d1781f1] API returning ams_mapping: [], ams_extruder_map: {}
+2026-10-16 10:23:49,621 DEBUG [backend.app.api.routes.printers] [8d1781f1] Using tray_now directly as global ID: 254
+2026-10-16 10:23:49,708 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:50,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:50,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:50,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:50,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:50,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:50,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:50,135 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:50,135 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [0]
+2026-10-16 10:23:50,135 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: /data/Metadata/plate_1.gcode, subtask: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:50,284 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:50,284 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:50,285 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:50,469 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: , subtask_name: Extension_Cord_Cover
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper raw value: 5.0
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper direct value: 5.0°C (heater OFF)
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'node': 'chamber_light', 'mode': 'off'}]
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Deferring developer mode probe (3.1s since connect, need 5s)
+2026-10-16 10:23:50,474 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: , subtask: Extension_Cord_Cover
+2026-10-16 10:23:51,246 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:51,246 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -42dBm
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [0]
+2026-10-16 10:23:51,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: /data/Metadata/plate_1.gcode, subtask: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:51,412 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:51,412 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:51,412 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-10-16 10:23:51,412 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:51,412 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:51,412 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:51,413 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:51,413 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:51,413 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:51,807 ERROR [backend.app.services.mqtt_relay] [-] MQTT relay connection failed: Not authorized
+2026-10-16 10:23:51,807 WARNING [backend.app.services.mqtt_relay] [-] MQTT relay disconnected: Unspecified error
+2026-10-16 10:23:52,149 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 1 — checking 2 AMS units
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 1 AMS 0 skipped — humidity 36 <= threshold 45
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 1 AMS 128 skipped — humidity 36 <= threshold 45
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 2 — checking 2 AMS units
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 2 AMS 0 skipped — humidity 35 <= threshold 45
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 2 AMS 128 skipped — humidity 31 <= threshold 45
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 3 skipped — model P1S does not support drying
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 4 skipped — model P1S does not support drying
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 5 skipped — model P1S does not support drying
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 6 skipped — model P1S does not support drying
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 7 skipped — model P1S does not support drying
+2026-10-16 10:23:52,150 DEBUG [backend.app.services.print_scheduler] [-] Auto-drying: printer 8 skipped — model P1S does not support drying
+2026-10-16 10:23:52,365 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [0]
+2026-10-16 10:23:52,366 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: /data/Metadata/plate_1.gcode, subtask: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:52,439 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:52,439 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Probing developer mode via ams_filament_setting (seq=3)
+2026-10-16 10:23:52,451 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: ams_filament_setting
+2026-10-16 10:23:52,451 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_filament_setting response: {'command': 'ams_filament_setting', 'ams_id': 255, 'tray_id': 0, 'slot_id': 0, 'tray_info_idx': 'GFG60', 'tray_type': 'PETG', 'tray_sub_brands': '', 'tray_color': '000000FF', 'nozzle_temp_min': '220', 'nozzle_temp_max': '260', 'sequence_id': '3', 'reason': 'success', 'result': 'success'}
+2026-10-16 10:23:52,451 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Developer mode probe: ENABLED (result='success')
+2026-10-16 10:23:52,501 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:52,502 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:52,863 ERROR [backend.app.services.mqtt_smart_plug] [-] MQTT smart plug connection failed: Not authorized
+2026-10-16 10:23:52,863 WARNING [backend.app.services.mqtt_smart_plug] [-] MQTT smart plug service disconnected: Unspecified error
+2026-10-16 10:23:53,063 DEBUG [backend.app.api.routes.printers] [5d40e1f5] API returning ams_mapping: [], ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:53,063 DEBUG [backend.app.api.routes.printers] [5d40e1f5] Using tray_now directly as global ID: 255
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FINISH, gcode_file: /data/Metadata/plate_1.gcode, subtask_name: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: [0]
+2026-10-16 10:23:53,505 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FINISH -> FINISH, file: /data/Metadata/plate_1.gcode, subtask: Gridfinity_Bins_1x2x6
+2026-10-16 10:23:53,673 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Found xcam inside print data: {'allow_skip_parts': False, 'buildplate_marker_detector': True, 'first_layer_inspector': True, 'halt_print_sensitivity': 'high', 'print_halt': True, 'printing_monitor': True, 'spaghetti_detector': True}
+2026-10-16 10:23:53,673 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Parsing xcam data - all fields: ['allow_skip_parts', 'buildplate_marker_detector', 'first_layer_inspector', 'halt_print_sensitivity', 'print_halt', 'printing_monitor', 'spaghetti_detector']
+2026-10-16 10:23:53,673 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: IDLE, gcode_file: , subtask_name: 
+2026-10-16 10:23:53,673 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0, '128': 0}
+2026-10-16 10:23:53,674 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:53,674 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-16 10:23:53,674 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'mode': 'off', 'node': 'chamber_light'}, {'mode': 'flashing', 'node': 'work_light'}]
+2026-10-16 10:23:53,674 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT mapping field: []
+2026-10-16 10:23:53,674 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: IDLE -> IDLE, file: , subtask: 
+2026-10-16 10:23:53,719 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:53,719 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -43dBm
+2026-10-16 10:23:53,998 DEBUG [backend.app.api.routes.printers] [0b49eaa1] API returning ams_mapping: [], ams_extruder_map: {}
+2026-10-16 10:23:53,998 DEBUG [backend.app.api.routes.printers] [0b49eaa1] Using tray_now directly as global ID: 254
+2026-10-16 10:23:54,254 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-16 10:23:54,254 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm