|
|
|
@@ -1,66 +1,107 @@
|
|
|
|
|
2025-04-19 21:40:53,869 - INFO - app.main - Application starting up...
|
|
|
|
|
2025-04-19 21:40:53,914 - INFO - app.main - Database initialized successfully
|
|
|
|
|
2025-04-19 21:40:53,914 - INFO - app.services.service_manager - Service OrderManagementService registered
|
|
|
|
|
2025-04-19 21:40:53,914 - INFO - app.services.service_manager - Service TCGPlayerInventoryService registered
|
|
|
|
|
2025-04-19 21:40:53,915 - INFO - app.services.service_manager - Service LabelPrinterService registered
|
|
|
|
|
2025-04-19 21:40:53,915 - INFO - app.services.service_manager - Service RegularPrinterService registered
|
|
|
|
|
2025-04-19 21:40:53,918 - INFO - app.services.service_manager - Service AddressLabelService registered
|
|
|
|
|
2025-04-19 21:40:53,920 - INFO - app.services.service_manager - Service PullSheetService registered
|
|
|
|
|
2025-04-19 21:40:53,920 - INFO - app.services.service_manager - Service SetLabelService registered
|
|
|
|
|
2025-04-19 21:40:53,920 - INFO - app.services.service_manager - Service DataInitializationService registered
|
|
|
|
|
2025-04-19 21:40:53,920 - DEBUG - tzlocal - /etc/localtime found
|
|
|
|
|
2025-04-19 21:40:53,921 - DEBUG - tzlocal - 1 found:
|
|
|
|
|
{'/etc/localtime is a symlink to': 'US/Michigan'}
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.service_manager - Service SchedulerService registered
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.service_manager - Service FileService registered
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.service_manager - Service TCGCSVService registered
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.service_manager - Service MTGJSONService registered
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.service_manager - All services initialized successfully
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.data_initialization - Starting data initialization process
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.data_initialization - Initializing MTGJSON data...
|
|
|
|
|
2025-04-19 21:40:53,921 - INFO - app.services.data_initialization - Starting MTGJSON initialization
|
|
|
|
|
2025-04-19 21:40:53,947 - DEBUG - app.services.external_api.mtgjson.mtgjson_service - Loaded SKUs from cache: app/data/cache/mtgjson/skus/TcgplayerSkus.json
|
|
|
|
|
2025-04-19 22:38:54,248 - INFO - app.services.data_initialization - Data initialization completed
|
|
|
|
|
2025-04-19 22:38:54,249 - INFO - app.main - Data initialization results: {'mtgjson': {'identifiers_processed': 0, 'skus_processed': 4764017}}
|
|
|
|
|
2025-04-19 22:38:54,249 - INFO - apscheduler.scheduler - Adding job tentatively -- it will be properly scheduled when the scheduler starts
|
|
|
|
|
2025-04-19 22:38:54,249 - INFO - app.services.scheduler.base_scheduler - Scheduled task update_open_orders_hourly to run every 3600 seconds
|
|
|
|
|
2025-04-19 22:38:54,249 - INFO - apscheduler.scheduler - Adding job tentatively -- it will be properly scheduled when the scheduler starts
|
|
|
|
|
2025-04-19 22:38:54,249 - INFO - app.services.scheduler.base_scheduler - Scheduled task update_all_orders_daily to run every 86400 seconds
|
|
|
|
|
2025-04-19 22:38:54,250 - INFO - apscheduler.scheduler - Added job "SchedulerService.start_scheduled_tasks.<locals>.<lambda>" to job store "default"
|
|
|
|
|
2025-04-19 22:38:54,250 - INFO - apscheduler.scheduler - Added job "SchedulerService.start_scheduled_tasks.<locals>.<lambda>" to job store "default"
|
|
|
|
|
2025-04-19 22:38:54,250 - INFO - apscheduler.scheduler - Scheduler started
|
|
|
|
|
2025-04-19 22:38:54,250 - INFO - app.services.scheduler.base_scheduler - Scheduler started
|
|
|
|
|
2025-04-19 22:38:54,250 - INFO - app.services.scheduler.scheduler_service - All scheduled tasks started
|
|
|
|
|
2025-04-19 22:38:54,250 - INFO - app.main - Scheduler started successfully
|
|
|
|
|
2025-04-19 22:38:54,251 - DEBUG - apscheduler.scheduler - Looking for jobs to run
|
|
|
|
|
2025-04-19 22:38:54,251 - DEBUG - apscheduler.scheduler - Next wakeup is due at 2025-04-19 23:38:54.249141-04:00 (in 3599.997778 seconds)
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service MTGJSONService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service mtgjson cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service TCGCSVService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service tcgcsv cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service FileService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service file cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.scheduler.base_scheduler - Scheduler stopped
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.scheduler.scheduler_service - Scheduler services closed
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service SchedulerService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.scheduler.scheduler_service - Scheduler services closed
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service scheduler cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service DataInitializationService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service data_initialization cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service SetLabelService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service set_label cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service PullSheetService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service pull_sheet cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service AddressLabelService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service address_label cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service RegularPrinterService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service regular_printer cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service LabelPrinterService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service label_printer cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service TCGPlayerInventoryService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service tcgplayer_inventory cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service OrderManagementService cleaned up
|
|
|
|
|
2025-04-19 22:53:56,053 - INFO - app.services.service_manager - Service order_management cleaned up
|
|
|
|
|
2025-04-19 22:53:56,054 - INFO - app.services.service_manager - All services cleaned up successfully
|
|
|
|
|
2025-04-19 22:53:56,054 - INFO - app.main - All services cleaned up successfully
|
|
|
|
|
2025-04-19 22:53:56,054 - INFO - apscheduler.scheduler - Scheduler has been shut down
|
|
|
|
|
2025-04-20 00:26:23,206 - INFO - app.main - Application starting up...
|
|
|
|
|
2025-04-20 00:26:23,441 - INFO - app.main - Database initialized successfully
|
|
|
|
|
2025-04-20 00:26:23,441 - INFO - app.services.service_manager - Service OrderManagementService registered
|
|
|
|
|
2025-04-20 00:26:23,442 - INFO - app.services.service_manager - Service TCGPlayerInventoryService registered
|
|
|
|
|
2025-04-20 00:26:23,442 - INFO - app.services.service_manager - Service LabelPrinterService registered
|
|
|
|
|
2025-04-20 00:26:23,443 - INFO - app.services.service_manager - Service RegularPrinterService registered
|
|
|
|
|
2025-04-20 00:26:23,447 - INFO - app.services.service_manager - Service AddressLabelService registered
|
|
|
|
|
2025-04-20 00:26:23,450 - INFO - app.services.service_manager - Service PullSheetService registered
|
|
|
|
|
2025-04-20 00:26:23,450 - INFO - app.services.service_manager - Service SetLabelService registered
|
|
|
|
|
2025-04-20 00:26:23,450 - INFO - app.services.service_manager - Service DataInitializationService registered
|
|
|
|
|
2025-04-20 00:26:23,450 - DEBUG - tzlocal - /etc/localtime found
|
|
|
|
|
2025-04-20 00:26:23,452 - DEBUG - tzlocal - 1 found:
|
|
|
|
|
{'/etc/localtime is a symlink to': 'America/Detroit'}
|
|
|
|
|
2025-04-20 00:26:23,452 - INFO - app.services.service_manager - Service SchedulerService registered
|
|
|
|
|
2025-04-20 00:26:23,452 - INFO - app.services.service_manager - Service FileService registered
|
|
|
|
|
2025-04-20 00:26:23,452 - INFO - app.services.service_manager - Service TCGCSVService registered
|
|
|
|
|
2025-04-20 00:26:23,452 - INFO - app.services.service_manager - Service MTGJSONService registered
|
|
|
|
|
2025-04-20 00:26:23,455 - INFO - app.services.service_manager - Service ManaboxService registered
|
|
|
|
|
2025-04-20 00:26:23,455 - INFO - app.services.service_manager - All services initialized successfully
|
|
|
|
|
2025-04-20 00:26:23,455 - INFO - app.services.data_initialization - Starting data initialization process
|
|
|
|
|
2025-04-20 00:26:23,456 - INFO - app.services.data_initialization - Data initialization completed
|
|
|
|
|
2025-04-20 00:26:23,456 - INFO - app.main - Data initialization results: {}
|
|
|
|
|
2025-04-20 00:26:23,456 - INFO - apscheduler.scheduler - Adding job tentatively -- it will be properly scheduled when the scheduler starts
|
|
|
|
|
2025-04-20 00:26:23,456 - INFO - app.services.scheduler.base_scheduler - Scheduled task update_open_orders_hourly to run every 3600 seconds
|
|
|
|
|
2025-04-20 00:26:23,456 - INFO - apscheduler.scheduler - Adding job tentatively -- it will be properly scheduled when the scheduler starts
|
|
|
|
|
2025-04-20 00:26:23,456 - INFO - app.services.scheduler.base_scheduler - Scheduled task update_all_orders_daily to run every 86400 seconds
|
|
|
|
|
2025-04-20 00:26:23,457 - INFO - apscheduler.scheduler - Added job "SchedulerService.start_scheduled_tasks.<locals>.<lambda>" to job store "default"
|
|
|
|
|
2025-04-20 00:26:23,457 - INFO - apscheduler.scheduler - Added job "SchedulerService.start_scheduled_tasks.<locals>.<lambda>" to job store "default"
|
|
|
|
|
2025-04-20 00:26:23,457 - INFO - apscheduler.scheduler - Scheduler started
|
|
|
|
|
2025-04-20 00:26:23,457 - INFO - app.services.scheduler.base_scheduler - Scheduler started
|
|
|
|
|
2025-04-20 00:26:23,457 - INFO - app.services.scheduler.scheduler_service - All scheduled tasks started
|
|
|
|
|
2025-04-20 00:26:23,457 - INFO - app.main - Scheduler started successfully
|
|
|
|
|
2025-04-20 00:26:23,457 - DEBUG - apscheduler.scheduler - Looking for jobs to run
|
|
|
|
|
2025-04-20 00:26:23,457 - DEBUG - apscheduler.scheduler - Next wakeup is due at 2025-04-20 01:26:23.456315-04:00 (in 3599.998465 seconds)
|
|
|
|
|
2025-04-20 00:26:39,542 - DEBUG - python_multipart.multipart - Calling on_part_begin with no data
|
|
|
|
|
2025-04-20 00:26:39,543 - DEBUG - python_multipart.multipart - Calling on_header_field with data[63:82]
|
|
|
|
|
2025-04-20 00:26:39,543 - DEBUG - python_multipart.multipart - Calling on_header_value with data[84:126]
|
|
|
|
|
2025-04-20 00:26:39,543 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:26:39,543 - DEBUG - python_multipart.multipart - Calling on_header_field with data[128:140]
|
|
|
|
|
2025-04-20 00:26:39,543 - DEBUG - python_multipart.multipart - Calling on_header_value with data[142:150]
|
|
|
|
|
2025-04-20 00:26:39,544 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:26:39,544 - DEBUG - python_multipart.multipart - Calling on_headers_finished with no data
|
|
|
|
|
2025-04-20 00:26:39,544 - DEBUG - python_multipart.multipart - Calling on_part_data with data[154:13032]
|
|
|
|
|
2025-04-20 00:26:39,551 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:27512]
|
|
|
|
|
2025-04-20 00:26:39,561 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:46336]
|
|
|
|
|
2025-04-20 00:26:39,562 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:7240]
|
|
|
|
|
2025-04-20 00:26:39,577 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:50680]
|
|
|
|
|
2025-04-20 00:26:39,578 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:46336]
|
|
|
|
|
2025-04-20 00:26:39,597 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:47784]
|
|
|
|
|
2025-04-20 00:26:39,599 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:37704]
|
|
|
|
|
2025-04-20 00:26:39,603 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:55024]
|
|
|
|
|
2025-04-20 00:26:39,613 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:45109]
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_part_end with no data
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_part_begin with no data
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_header_field with data[45174:45193]
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_header_value with data[45195:45219]
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_headers_finished with no data
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_part_data with data[45223:45230]
|
|
|
|
|
2025-04-20 00:26:39,614 - DEBUG - python_multipart.multipart - Calling on_part_end with no data
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_part_begin with no data
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_header_field with data[45295:45314]
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_header_value with data[45316:45338]
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_headers_finished with no data
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_part_data with data[45342:45358]
|
|
|
|
|
2025-04-20 00:26:39,615 - DEBUG - python_multipart.multipart - Calling on_part_end with no data
|
|
|
|
|
2025-04-20 00:26:39,616 - DEBUG - python_multipart.multipart - Calling on_end with no data
|
|
|
|
|
2025-04-20 00:26:48,984 - ERROR - app.services.manabox_service - Error: 2 TCGplayer SKUs found for Sword Coast Serpent // Capsizing Wave near_mint
|
|
|
|
|
2025-04-20 00:31:30,890 - DEBUG - python_multipart.multipart - Calling on_part_begin with no data
|
|
|
|
|
2025-04-20 00:31:30,891 - DEBUG - python_multipart.multipart - Calling on_header_field with data[63:82]
|
|
|
|
|
2025-04-20 00:31:30,892 - DEBUG - python_multipart.multipart - Calling on_header_value with data[84:126]
|
|
|
|
|
2025-04-20 00:31:30,892 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:31:30,892 - DEBUG - python_multipart.multipart - Calling on_header_field with data[128:140]
|
|
|
|
|
2025-04-20 00:31:30,892 - DEBUG - python_multipart.multipart - Calling on_header_value with data[142:150]
|
|
|
|
|
2025-04-20 00:31:30,892 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:31:30,892 - DEBUG - python_multipart.multipart - Calling on_headers_finished with no data
|
|
|
|
|
2025-04-20 00:31:30,893 - DEBUG - python_multipart.multipart - Calling on_part_data with data[154:13032]
|
|
|
|
|
2025-04-20 00:31:30,893 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:1448]
|
|
|
|
|
2025-04-20 00:31:30,904 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:28960]
|
|
|
|
|
2025-04-20 00:31:30,919 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:47784]
|
|
|
|
|
2025-04-20 00:31:30,920 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:8688]
|
|
|
|
|
2025-04-20 00:31:30,938 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:47784]
|
|
|
|
|
2025-04-20 00:31:30,939 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:50680]
|
|
|
|
|
2025-04-20 00:31:30,940 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:1448]
|
|
|
|
|
2025-04-20 00:31:30,962 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:4344]
|
|
|
|
|
2025-04-20 00:31:30,962 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:50680]
|
|
|
|
|
2025-04-20 00:31:30,963 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:60280]
|
|
|
|
|
2025-04-20 00:31:30,967 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:26064]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_data with data[0:35565]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_end with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_begin with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_header_field with data[35630:35649]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_header_value with data[35651:35675]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_headers_finished with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_data with data[35679:35686]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_end with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_begin with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_header_field with data[35751:35770]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_header_value with data[35772:35794]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_header_end with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_headers_finished with no data
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_data with data[35798:35814]
|
|
|
|
|
2025-04-20 00:31:30,979 - DEBUG - python_multipart.multipart - Calling on_part_end with no data
|
|
|
|
|
2025-04-20 00:31:30,980 - DEBUG - python_multipart.multipart - Calling on_end with no data
|
|
|
|
|
2025-04-20 00:31:40,209 - ERROR - app.services.manabox_service - Error: 2 TCGplayer SKUs found for Sword Coast Serpent // Capsizing Wave near_mint
|
|
|
|
|