Bug report logs e22cb4bde18447dfae8334cb16eec8fe.log

logs/e22cb4bde18447dfae8334cb16eec8fe.log

@@ -0,0 +1,140 @@
+2026-05-14 17:17:59,329 INFO [root] [-] Logging to file: /Users/[user]/bambuddy/logs/bambuddy.log
+2026-05-14 17:17:59,331 INFO [root] [-] Bambuddy starting - debug=False, log_level=INFO
+2026-05-14 17:18:00,044 INFO [backend.app.core.encryption] [-] Generated new MFA encryption key and saved to /Users/[user]/bambuddy/data/.mfa_encryption_key
+2026-05-14 17:18:00,098 INFO [backend.app.core.database] [-] Created default group: Administrators
+2026-05-14 17:18:00,098 INFO [backend.app.core.database] [-] Created default group: Operators
+2026-05-14 17:18:00,098 INFO [backend.app.core.database] [-] Created default group: Viewers
+2026-05-14 17:18:00,120 INFO [backend.app.core.database] [-] Seeded 91 default spool catalog entries
+2026-05-14 17:18:00,208 INFO [backend.app.core.database] [-] Seeded 638 default color catalog entries
+2026-05-14 17:18:00,239 INFO [backend.app.services.mqtt_relay] [-] MQTT relay disabled
+2026-05-14 17:18:00,241 INFO [backend.app.services.background_dispatch] [-] Background dispatch dispatcher started
+2026-05-14 17:18:00,241 INFO [backend.app.services.smart_plug_manager] [-] Smart plug scheduler started
+2026-05-14 17:18:00,241 INFO [backend.app.services.smart_plug_manager] [-] Smart plug energy snapshot loop started
+2026-05-14 17:18:00,243 INFO [backend.app.services.print_scheduler] [-] Print scheduler started
+2026-05-14 17:18:00,245 INFO [backend.app.services.notification_service] [-] Notification digest scheduler started
+2026-05-14 17:18:00,245 INFO [backend.app.services.github_backup] [-] Starting GitHub backup scheduler
+2026-05-14 17:18:00,245 INFO [backend.app.services.local_backup] [-] Starting local backup scheduler
+2026-05-14 17:18:00,246 INFO [backend.app.services.obico_detection] [-] Starting Obico detection service
+2026-05-14 17:18:00,246 INFO [backend.app.services.library_trash] [-] Starting library trash sweeper
+2026-05-14 17:18:00,246 INFO [backend.app.services.archive_purge] [-] Starting archive auto-purge sweeper
+2026-05-14 17:18:00,246 INFO [backend.app.main] [-] AMS history recording started
+2026-05-14 17:18:00,246 INFO [backend.app.main] [-] Printer runtime tracking started
+2026-05-14 17:18:00,246 INFO [backend.app.main] [-] SpoolBuddy watchdog started
+2026-05-14 17:18:00,246 INFO [backend.app.main] [-] Camera stream cleanup started
+2026-05-14 17:18:00,246 INFO [backend.app.main] [-] Expected prints cleanup started
+2026-05-14 17:18:00,246 INFO [backend.app.main] [-] Auth periodic cleanup started
+2026-05-14 17:18:00,248 INFO [root] [-] Virtual printer manager synced from database
+2026-05-14 17:18:03,666 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting...
+2026-05-14 17:18:03,666 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-05-14 17:18:03,666 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 0 printers
+2026-05-14 17:18:03,667 INFO [uvicorn.access] [-] [IP]:58028 - "POST /api/v1/printers/camera/stream-token HTTP/1.1" 200
+2026-05-14 17:18:03,722 INFO [backend.app.api.routes.websocket] [-] WebSocket client disconnected normally
+2026-05-14 17:18:03,732 INFO [uvicorn.access] [-] [IP]:58029 - "POST /api/v1/printers/camera/stream-token HTTP/1.1" 200
+2026-05-14 17:18:07,595 INFO [backend.app.api.routes.auth] [3bef4405] Setup completed: auth_enabled=False, admin_created=False
+2026-05-14 17:18:07,597 INFO [uvicorn.access] [-] [IP]:58038 - "POST /api/v1/auth/setup HTTP/1.1" 200
+2026-05-14 17:18:07,628 INFO [backend.app.api.routes.websocket] [-] WebSocket client connecting...
+2026-05-14 17:18:07,629 INFO [backend.app.api.routes.websocket] [-] WebSocket client connected
+2026-05-14 17:18:07,629 INFO [backend.app.api.routes.websocket] [-] Sent initial status for 0 printers
+2026-05-14 17:18:17,762 INFO [backend.app.services.camera] [0873a5a8] Found ffmpeg at: /opt/[user]/bin/ffmpeg
+2026-05-14 17:18:28,331 INFO [backend.app.api.routes.support] [bb7ea308] Log level changed to DEBUG
+2026-05-14 17:18:28,333 INFO [uvicorn.access] [-] [IP]:58070 - "POST /api/v1/support/debug-logging HTTP/1.1" 200
+2026-05-14 17:19:48,717 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:19:48,877 INFO [uvicorn.access] [-] [IP]:58128 - "POST /api/v1/printers/ HTTP/1.1" 200
+2026-05-14 17:19:48,906 INFO [uvicorn.access] [-] [IP]:58137 - "POST /api/v1/discovery/stop HTTP/1.1" 200
+2026-05-14 17:19:48,907 INFO [uvicorn.access] [-] [IP]:58136 - "POST /api/v1/discovery/scan/stop HTTP/1.1" 200
+2026-05-14 17:19:50,173 INFO [backend.app.services.firmware_check] [06e559fc] Got Bambu Lab build ID: DGVvLxp_mb7yePrzlGQYu
+2026-05-14 17:19:50,487 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:19:53,266 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:19:58,034 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:19:59,835 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:00,069 INFO [uvicorn.access] [-] [IP]:58154 - "POST /api/v1/printers/1/connect HTTP/1.1" 200
+2026-05-14 17:20:00,092 DEBUG [backend.app.api.routes.printers] [54254993] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:20:00,093 DEBUG [backend.app.api.routes.printers] [54254993] Using tray_now directly as global ID: 255
+2026-05-14 17:20:01,580 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:01,904 WARNING [backend.app.services.bambu_mqtt] [a77c3d19] [[SERIAL]] request_status_update: not connected
+2026-05-14 17:20:01,906 INFO [uvicorn.access] [-] [IP]:58154 - "POST /api/v1/printers/1/refresh-status HTTP/1.1" 400
+2026-05-14 17:20:04,344 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:09,127 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:15,304 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:20:17,890 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:30,296 INFO [backend.app.api.routes.support] [d153bf3c] Log level changed to INFO
+2026-05-14 17:20:30,298 INFO [uvicorn.access] [-] [IP]:58187 - "POST /api/v1/support/debug-logging HTTP/1.1" 200
+2026-05-14 17:20:34,663 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:42,584 INFO [backend.app.api.routes.support] [6efc2e40] Log level changed to DEBUG
+2026-05-14 17:20:42,586 INFO [uvicorn.access] [-] [IP]:58190 - "POST /api/v1/support/debug-logging HTTP/1.1" 200
+2026-05-14 17:20:45,309 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:20:55,541 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:20:55,775 INFO [uvicorn.access] [-] [IP]:58210 - "POST /api/v1/printers/1/connect HTTP/1.1" 200
+2026-05-14 17:20:55,791 DEBUG [backend.app.api.routes.printers] [a7a122e8] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:20:55,792 DEBUG [backend.app.api.routes.printers] [a7a122e8] Using tray_now directly as global ID: 255
+2026-05-14 17:20:57,297 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:21:00,044 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:21:00,398 INFO [uvicorn.access] [-] [IP]:58218 - "POST /api/v1/printers/1/logging/enable HTTP/1.1" 200
+2026-05-14 17:21:04,834 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:21:07,758 WARNING [backend.app.services.bambu_mqtt] [8a50b815] [[SERIAL]] request_status_update: not connected
+2026-05-14 17:21:07,760 INFO [uvicorn.access] [-] [IP]:58222 - "POST /api/v1/printers/1/refresh-status HTTP/1.1" 400
+2026-05-14 17:21:13,581 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:21:14,296 INFO [backend.app.api.routes.support] [5feddbb0] Generated support bundle: bambuddy-support-20260514-172114.zip
+2026-05-14 17:21:15,315 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:21:30,369 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:21:45,319 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:22:01,159 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:02,910 DEBUG [backend.app.api.routes.printers] [58f88418] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:22:02,910 DEBUG [backend.app.api.routes.printers] [58f88418] Using tray_now directly as global ID: 255
+2026-05-14 17:22:07,017 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:07,204 INFO [uvicorn.access] [-] [IP]:58266 - "POST /api/v1/printers/1/connect HTTP/1.1" 200
+2026-05-14 17:22:07,225 DEBUG [backend.app.api.routes.printers] [764b1359] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:22:07,225 DEBUG [backend.app.api.routes.printers] [764b1359] Using tray_now directly as global ID: 255
+2026-05-14 17:22:08,783 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:11,549 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:15,324 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:22:16,319 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:25,076 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:37,249 DEBUG [backend.app.api.routes.printers] [d5c7dd16] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:22:37,249 DEBUG [backend.app.api.routes.printers] [d5c7dd16] Using tray_now directly as global ID: 255
+2026-05-14 17:22:41,840 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:22:45,332 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:23:07,266 DEBUG [backend.app.api.routes.printers] [85d2682f] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:23:07,266 DEBUG [backend.app.api.routes.printers] [85d2682f] Using tray_now directly as global ID: 255
+2026-05-14 17:23:12,636 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:23:15,340 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:23:27,595 INFO [backend.app.api.routes.support] [f60020ed] Log level changed to INFO
+2026-05-14 17:23:27,596 INFO [uvicorn.access] [-] [IP]:58354 - "POST /api/v1/support/debug-logging HTTP/1.1" 200
+2026-05-14 17:23:43,403 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:24:14,182 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:24:44,940 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:25:15,716 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:25:37,586 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:25:37,835 INFO [uvicorn.access] [-] [IP]:58466 - "POST /api/v1/printers/1/connect HTTP/1.1" 200
+2026-05-14 17:25:39,367 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:25:42,149 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:25:46,909 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:25:55,690 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:26:12,474 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:26:43,231 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:27:14,007 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:27:44,761 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:05,595 INFO [backend.app.api.routes.support] [82d25229] Log level changed to DEBUG
+2026-05-14 17:28:05,596 INFO [backend.app.api.routes.bug_report] [82d25229] Bug report: enabled debug logging
+2026-05-14 17:28:05,597 WARNING [backend.app.services.bambu_mqtt] [82d25229] [[SERIAL]] request_status_update: not connected
+2026-05-14 17:28:05,598 INFO [uvicorn.access] [-] [IP]:58612 - "POST /api/v1/bug-report/start-logging HTTP/1.1" 200
+2026-05-14 17:28:07,944 DEBUG [backend.app.api.routes.printers] [193b6194] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:28:07,944 DEBUG [backend.app.api.routes.printers] [193b6194] Using tray_now directly as global ID: 255
+2026-05-14 17:28:15,406 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:28:15,539 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:22,335 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:22,587 INFO [uvicorn.access] [-] [IP]:58618 - "POST /api/v1/printers/1/connect HTTP/1.1" 200
+2026-05-14 17:28:22,599 DEBUG [backend.app.api.routes.printers] [ab1a4e5a] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:28:22,599 DEBUG [backend.app.api.routes.printers] [ab1a4e5a] Using tray_now directly as global ID: 255
+2026-05-14 17:28:24,102 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:26,901 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:31,690 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:33,697 WARNING [backend.app.services.bambu_mqtt] [4e580ccd] [[SERIAL]] request_status_update: not connected
+2026-05-14 17:28:33,698 INFO [uvicorn.access] [-] [IP]:58635 - "POST /api/v1/printers/1/refresh-status HTTP/1.1" 400
+2026-05-14 17:28:40,444 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:45,248 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)
+2026-05-14 17:28:45,415 DEBUG [backend.app.main] [-] [[PRINTER]] Runtime tracking: not connected
+2026-05-14 17:28:45,490 INFO [uvicorn.access] [-] [IP]:58638 - "POST /api/v1/printers/1/connect HTTP/1.1" 200
+2026-05-14 17:28:45,502 DEBUG [backend.app.api.routes.printers] [5eae202f] API returning ams_mapping: [], ams_extruder_map: {}
+2026-05-14 17:28:45,502 DEBUG [backend.app.api.routes.printers] [5eae202f] Using tray_now directly as global ID: 255
+2026-05-14 17:28:47,012 WARNING [backend.app.services.bambu_mqtt] [-] [[SERIAL]] MQTT disconnected: rc=Unspecified error, flags=DisconnectFlags(is_disconnect_packet_from_server=False)