diff --git a/logs/98f26fcd41c9444d8c5e01784c577dee.log b/logs/98f26fcd41c9444d8c5e01784c577dee.log
new file mode 100644
index 000000000..7828c3beb
--- /dev/null
+++ b/logs/98f26fcd41c9444d8c5e01784c577dee.log
@@ -0,0 +1,200 @@
+2026-10-06 18:13:40,467 INFO [uvicorn.access] [-] [IP]:36766 - "POST /api/v1/auth/media-token HTTP/1.1" 200
+2026-10-06 18:13:40,890 INFO [uvicorn.access] [-] [IP]:54940 - "POST /api/v1/auth/ws-token HTTP/1.1" 200
+2026-10-06 18:13:41,010 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting (principal=[USER])
+2026-10-06 18:13:41,018 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-10-06 18:13:41,019 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 1 printers
+2026-10-06 18:13:41,101 INFO [backend.app.api.routes.cloud] [120d4f74] get_filament_info called with 2 IDs: ['GFG99', 'GFL03']
+2026-10-06 18:13:41,491 INFO [uvicorn.access] [-] [IP]:55066 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-10-06 18:13:44,441 INFO [backend.app.api.routes.websocket] [-] WebSocket client disconnected normally
+2026-10-06 18:13:45,668 INFO [uvicorn.access] [-] [IP]:54972 - "POST /api/v1/auth/media-token HTTP/1.1" 200
+2026-10-06 18:13:45,745 INFO [uvicorn.access] [-] [IP]:55066 - "POST /api/v1/printers/camera/stream-token HTTP/1.1" 200
+2026-10-06 18:13:46,017 INFO [uvicorn.access] [-] [IP]:54940 - "POST /api/v1/auth/ws-token HTTP/1.1" 200
+2026-10-06 18:13:46,100 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting (principal=[USER])
+2026-10-06 18:13:46,121 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-10-06 18:13:46,121 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 1 printers
+2026-10-06 18:13:46,219 INFO [backend.app.api.routes.cloud] [66f515a4] get_filament_info called with 2 IDs: ['GFG99', 'GFL03']
+2026-10-06 18:13:46,220 INFO [uvicorn.access] [-] [IP]:36846 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-10-06 18:13:52,164 INFO [backend.app.services.smart_plug_manager] [-] Captured 1 energy snapshot(s)
+2026-10-06 18:14:03,658 INFO [backend.app.api.routes.print_queue] [4327aef7] Added library file 5 to queue for 1
+2026-10-06 18:14:03,662 INFO [uvicorn.access] [-] [IP]:43602 - "POST /api/v1/queue/ HTTP/1.1" 200
+2026-10-06 18:14:22,362 INFO [backend.app.services.announcements] [-] Announcements feed #12: 2 for this install
+2026-10-06 18:14:22,382 INFO [backend.app.services.print_scheduler] [-] Queue check: found 1 pending items: [(63, 1, None, 5)]
+2026-10-06 18:14:22,402 INFO [backend.app.services.print_scheduler] [-] Queue: printer 1 reserved — selected for dispatch in this pass
+2026-10-06 18:14:22,405 INFO [backend.app.services.print_scheduler] [-] Launching 1 upload(s) (pool 0/4 in flight)
+2026-10-06 18:14:22,412 INFO [backend.app.services.print_scheduler] [-] Starting queue item 63
+2026-10-06 18:14:22,455 INFO [backend.app.services.print_scheduler] [-] Queue item 63: Created archive 64 from library file 5
+2026-10-06 18:14:22,464 INFO [backend.app.services.print_scheduler] [-] Queue item 63: FTP upload starting - printer=[PRINTER] (P1S), ip=[IP], file=Playmobil_wheel_axle_-_3177332_-_v2.3mf, local_path=/app/data/archive/library/files/70f62a2a762a45b8ab1939e722929018.3mf, retry_enabled=True, retry_count=3, timeout=30.0
+2026-10-06 18:14:23,250 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:14:23,267 INFO [backend.app.services.bambu_ftp] [-] FTP connecting to [IP] for upload (model=P1S, mode=prot_p, socket_timeout=30.0s, deadline=600s)...
+2026-10-06 18:14:24,062 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:14:24,062 INFO [backend.app.services.bambu_ftp] [-] FTP connected to [IP]
+2026-10-06 18:14:24,062 INFO [backend.app.services.bambu_ftp] [-] FTP uploading /app/data/archive/library/files/70f62a2a762a45b8ab1939e722929018.3mf (735650 bytes) to /Playmobil_wheel_axle_-_3177332_-_v2.3mf
+2026-10-06 18:14:24,131 INFO [backend.app.services.bambu_ftp] [-] FTP data channel ready in 0.1s (PASV + TLS handshake)
+2026-10-06 18:14:28,914 INFO [backend.app.services.bambu_ftp] [-] FTP STOR confirmed for /Playmobil_wheel_axle_-_3177332_-_v2.3mf: 226
+2026-10-06 18:14:28,918 INFO [backend.app.services.bambu_ftp] [-] FTP upload complete: /Playmobil_wheel_axle_-_3177332_-_v2.3mf (735650 bytes in 4.9s, 148 KB/s)
+2026-10-06 18:14:28,918 INFO [backend.app.services.bambu_ftp] [-] FTP mode cached for [IP]: prot_p
+2026-10-06 18:14:28,943 INFO [backend.app.main] [-] Registered expected print: printer=1, file=Playmobil_wheel_axle_-_3177332_-_v2.3mf, archive=64, ams_mapping=[1], plate_id=1
+2026-10-06 18:14:28,951 INFO [backend.app.services.print_scheduler] [-] Queue item 63: Status set to 'printing', sending print command...
+2026-10-06 18:14:28,960 INFO [backend.app.services.printer_manager] [-] PRINT COMMAND: printer=1, file=Playmobil_wheel_axle_-_3177332_-_v2.3mf, caller=print_scheduler.py:2431:_dispatch_one
+2026-10-06 18:14:28,960 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Sending print command: {"print": {"sequence_id": "20000", "command": "project_file", "param": "Metadata/plate_1.gcode", "url": "ftp://Playmobil_wheel_axle_-_3177332_-_v2.3mf", "file": "Playmobil_wheel_axle_-_3177332_-_v2.3mf", "md5": "", "bed_type": "auto", "timelapse": false, "bed_leveling": true, "auto_bed_leveling": 1, "flow_cali": false, "vibration_cali": false, "layer_inspect": true, "use_ams": true, "extrude_cali_flag": 0, "extrude_cali_manual_mode": 0, "nozzle_offset_cali": 0, "subtask_name": "Playmobil_wheel_axle_-_3177332_-_v2", "profile_id": "0", "project_id": "301907362", "subtask_id": "301907362", "task_id": "301907362", "ams_mapping": [1], "ams_mapping2": [{"ams_id": 0, "slot_id": 1}]}}
+2026-10-06 18:14:28,961 INFO [backend.app.services.print_scheduler] [-] Queue item 63: Print started successfully - Playmobil_wheel_axle_-_3177332_-_v2.gcode.3mf
+2026-10-06 18:14:41,162 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] PRINT START detected - file: Playmobil_wheel_axle_-_3177332_-_v2.3mf, subtask: Playmobil_wheel_axle_-_3177332_-_v2, is_new: True, is_file_change: False
+2026-10-06 18:14:41,162 INFO [backend.app.main] [-] [CALLBACK] on_print_start called for printer 1, data keys: ['filename', 'subtask_name', 'remaining_time', 'raw_data', 'ams_mapping']
+2026-10-06 18:14:41,165 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] Skipped trays with invalid remain% for printer 1: AMS0-T0(remain=-1), AMS0-T1(remain=-1), AMS0-T2(remain=-1), AMS0-T3(remain=-1)
+2026-10-06 18:14:41,166 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] PRINT START printer 1: mapping=None, tray_now=255, last_loaded_tray=-1
+2026-10-06 18:14:41,166 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] PRINT START printer 1: mapping-related keys: {'ams_extruder_map': {'0': 0}}
+2026-10-06 18:14:41,166 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] PRINT START printer 1 AMS 0: T0(type=, color=, now=?, tar=?), T1(type=PETG, color=C0C0C0FF, now=?, tar=?), T2(type=PLA, color=E1E9E9FF, now=?, tar=?), T3(type=PETG, color=353434FF, now=?, tar=?)
+2026-10-06 18:14:41,168 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] Snapshotted 3 spool assignments for printer 1: {'0-1': 3, '0-2': 1, '0-3': 10}
+2026-10-06 18:14:41,174 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] Captured start remain% for printer 1 (1 trays): {'255-0': 0}
+2026-10-06 18:14:41,179 INFO [backend.app.main] [-] [PLATE CHECK] printer_id=1, plate_detection_enabled=False
+2026-10-06 18:14:41,179 INFO [backend.app.main] [-] [CALLBACK] Print start detected - filename: Playmobil_wheel_axle_-_3177332_-_v2.3mf, subtask: Playmobil_wheel_axle_-_3177332_-_v2
+2026-10-06 18:14:41,179 INFO [backend.app.main] [-] Using expected archive 64 for print (skipping duplicate)
+2026-10-06 18:14:41,191 INFO [backend.app.main] [-] [CALLBACK] Injected ams_mapping into usage tracker session: [1]
+2026-10-06 18:14:41,227 INFO [backend.app.main] [-] [ENERGY] Recorded starting energy (expected-print) for archive 64 from plug 'Powerplug 7': 92.91 kWh
+2026-10-06 18:14:41,230 INFO [backend.app.main] [-] [SNAPSHOT] Capturing fresh frame for printer 1
+2026-10-06 18:14:41,231 INFO [backend.app.services.camera] [-] Capturing camera frame bytes from [IP] using chamber image protocol (model: P1S)
+2026-10-06 18:14:41,297 INFO [backend.app.api.routes.printers] [64f30946] Cover: resolved plate 1 before download (subtask=Playmobil_wheel_axle_-_3177332_-_v2)
+2026-10-06 18:14:41,307 INFO [backend.app.api.routes.printers] [64f30946] Cover using cached 3MF from /app/data/archive/library/files/70f62a2a762a45b8ab1939e722929018.3mf (avoided duplicate FTP)
+2026-10-06 18:14:41,308 INFO [backend.app.api.routes.printers] [64f30946] Downloaded file size: 735650 bytes
+2026-10-06 18:14:43,040 INFO [backend.app.main] [-] [SNAPSHOT] Fresh camera frame: 86330 bytes
+2026-10-06 18:14:43,040 INFO [backend.app.services.notification_service] [-] on_print_start called for printer 1 ([PRINTER])
+2026-10-06 18:14:43,043 INFO [backend.app.services.notification_service] [-] No notification providers configured for print_start event on printer 1
+2026-10-06 18:14:43,045 INFO [backend.app.main] [-] Loaded 1 printable objects for printer 1
+2026-10-06 18:14:43,913 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:14:44,826 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:14:44,839 INFO [backend.app.services.bambu_ftp] [-] FTP list_files failed for /timelapse/video: 550 
+2026-10-06 18:14:45,680 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:14:45,693 INFO [backend.app.services.bambu_ftp] [-] FTP list_files failed for /record: 550 
+2026-10-06 18:14:46,537 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:14:46,555 INFO [backend.app.services.bambu_ftp] [-] FTP list_files failed for /recording: 550 
+2026-10-06 18:14:46,570 INFO [backend.app.main] [-] [TIMELAPSE] Baseline at print start: 0 video files for printer 1
+2026-10-06 18:15:05,098 INFO [backend.app.services.bambu_mqtt] [8780cbe1] [[SERIAL]] Sent stop print command
+2026-10-06 18:15:05,098 INFO [backend.app.main] [8780cbe1] Marked printer 1 as user-stopped from queue
+2026-10-06 18:15:05,099 INFO [uvicorn.access] [-] [IP]:33252 - "POST /api/v1/printers/1/print/stop HTTP/1.1" 200
+2026-10-06 18:15:09,514 INFO [backend.app.services.bambu_mqtt] [-] [[SERIAL]] PRINT COMPLETE detected - state: FAILED, status: failed, file: Playmobil_wheel_axle_-_3177332_-_v2.3mf, subtask: Playmobil_wheel_axle_-_3177332_-_v2, was_running: True, timelapse_during_print: False
+2026-10-06 18:15:09,515 INFO [backend.app.main] [-] [CALLBACK] on_print_complete started for printer 1
+2026-10-06 18:15:09,522 INFO [backend.app.main] [-] [TIMING] WebSocket send_print_complete: 0.007s elapsed
+2026-10-06 18:15:09,522 INFO [backend.app.main] [-] [CALLBACK] Overriding status 'failed' -> 'cancelled' for printer 1 (print was stopped from queue by user)
+2026-10-06 18:15:09,522 INFO [backend.app.main] [-] Print complete - filename: Playmobil_wheel_axle_-_3177332_-_v2.3mf, subtask: Playmobil_wheel_axle_-_3177332_-_v2, status: cancelled
+2026-10-06 18:15:09,523 INFO [backend.app.main] [-] Looking for archive in _active_prints, keys to try: [(1, 'Playmobil_wheel_axle_-_3177332_-_v2.3mf'), (1, 'Playmobil_wheel_axle_-_3177332_-_v2.gcode.3mf'), (1, 'Playmobil_wheel_axle_-_3177332_-_v2'), (1, 'Playmobil_wheel_axle_-_3177332_-_v2.3mf'), (1, 'Playmobil_wheel_axle_-_3177332_-_v2.3mf')]...
+2026-10-06 18:15:09,523 INFO [backend.app.main] [-] Current _active_prints: [(1, 'Playmobil_wheel_axle_-_3177332_-_v2.gcode.3mf'), (1, 'Playmobil_wheel_axle_-_3177332_-_v2.3mf')]
+2026-10-06 18:15:09,523 INFO [backend.app.main] [-] Found archive 64 with key (1, 'Playmobil_wheel_axle_-_3177332_-_v2.3mf')
+2026-10-06 18:15:10,340 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:15:10,390 INFO [backend.app.main] [-] Deleted /Playmobil_wheel_axle_-_3177332_-_v2.3mf from printer [PRINTER] SD card
+2026-10-06 18:15:11,206 INFO [backend.app.services.bambu_ftp] [-] FTP connected successfully to [IP] (model=P1S, prot_c=False)
+2026-10-06 18:15:11,228 INFO [backend.app.main] [-] [TIMING] SD card cleanup: 1.713s elapsed
+2026-10-06 18:15:11,233 INFO [backend.app.main] [-] Updated queue item 63 status to cancelled
+2026-10-06 18:15:11,246 INFO [backend.app.main] [-] [TIMING] Queue item update: 1.731s elapsed
+2026-10-06 18:15:11,251 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] on_print_complete: printer=1, archive=64, session=yes, ams_mapping=[1]
+2026-10-06 18:15:11,251 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] PRINT COMPLETE printer 1: mapping=None, tray_now=255, last_loaded_tray=-1
+2026-10-06 18:15:11,253 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] 3MF: archive 64, plate_id=1, filament_usage=[{'slot_id': 1, 'used_g': 1.82, 'type': 'PETG', 'color': '#00AE42'}]
+2026-10-06 18:15:11,253 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] 3MF: slot_to_tray=[1] (source: print_cmd)
+2026-10-06 18:15:11,253 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] 3MF: slot_id=1 -> global_tray=1 -> AMS0-T1 (used_g=1.8, tray_now_override=None)
+2026-10-06 18:15:11,257 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] AMS0-T1: no valid remain% at print start, nothing to charge for printer 1
+2026-10-06 18:15:11,257 INFO [backend.app.services.usage_tracker] [-] [UsageTracker] VT254: not in print mapping/tray_change_log — skipping fallback for printer 1
+2026-10-06 18:15:11,263 INFO [backend.app.main] [-] [TIMING] Filament usage tracking: 1.749s elapsed
+2026-10-06 18:15:11,264 INFO [backend.app.main] [-] [TIMING] Archive lookup: 1.749s elapsed
+2026-10-06 18:15:11,264 INFO [backend.app.main] [-] [ARCHIVE] Updating archive 64 status...
+2026-10-06 18:15:11,264 INFO [backend.app.main] [-] [ARCHIVE] failure_reason='userCancelled' (status=cancelled)
+2026-10-06 18:15:11,271 INFO [backend.app.main] [-] [ARCHIVE] Archive 64 status updated to cancelled, failure_reason=userCancelled
+2026-10-06 18:15:11,271 INFO [backend.app.main] [-] [ARCHIVE] WebSocket notification sent for archive 64
+2026-10-06 18:15:11,271 INFO [backend.app.main] [-] [TIMING] Archive status update: 1.757s elapsed
+2026-10-06 18:15:11,278 INFO [backend.app.services.finance_billing] [-] Billing is disabled; skipping print charge for archive ID 64.
+2026-10-06 18:15:11,278 INFO [backend.app.main] [-] [TIMING] Finance charge update: 1.764s elapsed
+2026-10-06 18:15:11,292 INFO [backend.app.main] [-] [PRINT_LOG] Log entry written for archive 64
+2026-10-06 18:15:11,293 INFO [backend.app.main] [-] [TIMING] Print log entry: 1.778s elapsed
+2026-10-06 18:15:11,293 INFO [backend.app.main] [-] [TIMING] Background tasks scheduled (energy, photo): 1.778s elapsed
+2026-10-06 18:15:11,293 INFO [backend.app.main] [-] [TIMING] All background tasks scheduled: 1.778s elapsed
+2026-10-06 18:15:11,293 INFO [backend.app.main] [-] [CALLBACK] on_print_complete finished for printer 1, archive 64
+2026-10-06 18:15:11,293 INFO [backend.app.main] [-] [ENERGY-BG] Starting energy calculation for archive 64
+2026-10-06 18:15:11,294 INFO [backend.app.main] [-] [PHOTO-BG] Starting finish photo capture for archive 64
+2026-10-06 18:15:11,294 INFO [backend.app.main] [-] [AUTO-OFF-BG] Starting smart plug au[USER]ation for printer 1
+2026-10-06 18:15:11,294 INFO [backend.app.services.smart_plug_manager] [-] Print on printer 1 ended with status 'cancelled', skipping auto-off to allow investigation
+2026-10-06 18:15:11,294 INFO [backend.app.main] [-] [AUTO-OFF-BG] Completed
+2026-10-06 18:15:11,295 INFO [backend.app.main] [-] [LAYER-TL] Cancelled layer timelapse for printer 1 (status: cancelled)
+2026-10-06 18:15:11,301 INFO [backend.app.services.camera] [-] Capturing camera frame bytes from [IP] using chamber image protocol (model: P1S)
+2026-10-06 18:15:11,316 INFO [backend.app.main] [-] [ENERGY-BG] Energy response from plug 'Powerplug 7': {'power': 987.41, 'voltage': None, 'current': None, 'today': None, 'total': 92.91, 'yesterday': None, 'factor': None, 'apparent_power': None, 'reactive_power': None}
+2026-10-06 18:15:11,317 INFO [backend.app.main] [-] [ENERGY-BG] Per-print energy: 0.0 kWh
+2026-10-06 18:15:11,327 INFO [backend.app.main] [-] [ENERGY-BG] Saved: 0.0 kWh, cost=0.0
+2026-10-06 18:15:13,148 INFO [backend.app.services.camera] [-] Saved camera frame to: /app/data/archive/1/20261006_181422_Playmobil_wheel_axle_-_3177332_-_v2/photos/finish_20261006_181511_ca20749d.jpg
+2026-10-06 18:15:13,149 INFO [backend.app.services.camera] [-] Finish photo saved: finish_20261006_181511_ca20749d.jpg
+2026-10-06 18:15:13,153 INFO [backend.app.main] [-] [PHOTO-BG] Saved: finish_20261006_181511_ca20749d.jpg
+2026-10-06 18:15:13,153 INFO [backend.app.main] [-] [PHOTO-NOTIFY] Photo task returned: finish_20261006_181511_ca20749d.jpg
+2026-10-06 18:15:13,153 INFO [backend.app.main] [-] [NOTIFY-BG] Starting notifications for printer 1, photo=finish_20261006_181511_ca20749d.jpg
+2026-10-06 18:15:13,157 INFO [backend.app.main] [-] [NOTIFY-BG] Loaded finish photo bytes: 85883 bytes
+2026-10-06 18:15:13,157 INFO [backend.app.services.notification_service] [-] on_print_complete called for printer 1 ([PRINTER]), status=cancelled
+2026-10-06 18:15:13,160 INFO [backend.app.services.notification_service] [-] Found 1 providers for on_print_stopped: ['Notifying Tom']
+2026-10-06 18:15:13,405 INFO [backend.app.services.notification_service] [-] Sent notification via Notifying Tom
+2026-10-06 18:15:13,407 INFO [backend.app.main] [-] [NOTIFY-BG] Completed
+2026-10-06 18:15:13,574 INFO [backend.app.api.routes.websocket] [-] WebSocket client disconnected normally
+2026-10-06 18:18:32,322 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:23:32,332 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:28:32,340 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:33:32,349 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:38:32,357 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:40:47,166 INFO [uvicorn.access] [-] [IP]:56860 - "POST /api/v1/auth/ws-token HTTP/1.1" 200
+2026-10-06 18:40:47,229 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting (principal=[USER])
+2026-10-06 18:40:47,237 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-10-06 18:40:47,238 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 1 printers
+2026-10-06 18:40:47,278 INFO [backend.app.api.routes.cloud] [746b2742] get_filament_info called with 2 IDs: ['GFG99', 'GFL03']
+2026-10-06 18:40:47,693 INFO [uvicorn.access] [-] [IP]:56860 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-10-06 18:42:05,485 INFO [uvicorn.access] [-] [IP]:55994 - "POST /api/v1/auth/ws-token HTTP/1.1" 200
+2026-10-06 18:42:05,516 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting (principal=[USER])
+2026-10-06 18:42:05,518 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-10-06 18:42:05,519 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 1 printers
+2026-10-06 18:42:27,234 INFO [backend.app.api.routes.websocket] [-] WebSocket client disconnected normally
+2026-10-06 18:43:32,367 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:46:03,582 INFO [backend.app.api.routes.cloud] [eefe8ce4] get_filament_info called with 2 IDs: ['GFG99', 'GFL03']
+2026-10-06 18:46:04,005 INFO [uvicorn.access] [-] [IP]:49974 - "POST /api/v1/cloud/filament-info HTTP/1.1" 200
+2026-10-06 18:47:39,321 INFO [backend.app.api.routes.support] [5010518f] Log level changed to DEBUG
+2026-10-06 18:47:39,322 INFO [backend.app.api.routes.bug_report] [5010518f] Bug report: enabled debug logging
+2026-10-06 18:47:39,322 DEBUG [backend.app.services.bambu_mqtt] [5010518f] [[SERIAL]] Requesting status update (pushall)
+2026-10-06 18:47:39,322 INFO [uvicorn.access] [-] [IP]:57408 - "POST /api/v1/bug-report/start-logging HTTP/1.1" 200
+2026-10-06 18:47:39,766 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received gcode_state: FAILED, gcode_file: , subtask_name: Playmobil_wheel_axle_-_3177332_-_v2
+2026-10-06 18:47:39,766 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': 5, 'insert_flag': True, 'power_on_flag': False}
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] tray_now updated: 255
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Merged AMS data: 1 new units, 1 total
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] AMS 0 info=0x2003 -> extruder 0
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_extruder_map: {'0': 0}
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] ams_status: 0 (main=0, sub=0)
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper raw value: 5.0
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] chamber_temper direct value: 5.0°C (heater OFF)
+2026-10-06 18:47:39,767 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber heating calculated: target=0.0, current=5.0, heating=False, respect_local=False
+2026-10-06 18:47:39,768 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Chamber temp updated to: 5.0, target: 0.0, heating: False
+2026-10-06 18:47:39,768 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] HMS data received: []
+2026-10-06 18:47:39,768 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-10-06 18:47:39,768 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -39dBm
+2026-10-06 18:47:39,768 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] lights_report: [{'node': 'chamber_light', 'mode': 'on'}]
+2026-10-06 18:47:39,768 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] gcode_state: FAILED -> FAILED, file: , subtask: Playmobil_wheel_axle_-_3177332_-_v2
+2026-10-06 18:47:41,793 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:47:41,793 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm
+2026-10-06 18:47:43,844 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:47:43,844 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -38dBm
+2026-10-06 18:47:45,873 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:47:49,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:47:49,903 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm
+2026-10-06 18:47:53,960 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:47:58,008 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:03,907 DEBUG [backend.app.api.routes.printers] [b536b7fd] API returning ams_mapping: [], ams_extruder_map: {'0': 0}
+2026-10-06 18:48:03,907 DEBUG [backend.app.api.routes.printers] [b536b7fd] Using tray_now directly as global ID: 255
+2026-10-06 18:48:08,105 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:08,105 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -38dBm
+2026-10-06 18:48:10,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:10,134 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm
+2026-10-06 18:48:16,167 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:16,167 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -38dBm
+2026-10-06 18:48:18,182 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:18,182 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm
+2026-10-06 18:48:26,233 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:26,233 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -38dBm
+2026-10-06 18:48:28,252 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:28,252 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm
+2026-10-06 18:48:32,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:32,274 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -38dBm
+2026-10-06 18:48:32,376 INFO [backend.app.main] [-] Recorded 1 AMS sensor history entries
+2026-10-06 18:48:32,493 DEBUG [backend.app.main] [-] Recorded 3 printer sensor history entries
+2026-10-06 18:48:33,943 DEBUG [backend.app.api.routes.printers] [eb65e96e] API returning ams_mapping: [], ams_extruder_map: {'0': 0}
+2026-10-06 18:48:33,943 DEBUG [backend.app.api.routes.printers] [eb65e96e] Using tray_now directly as global ID: 255
+2026-10-06 18:48:34,290 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] Received command response: push_status
+2026-10-06 18:48:34,291 DEBUG [backend.app.services.bambu_mqtt] [-] [[SERIAL]] wifi_signal received: -37dBm
\ No newline at end of file