INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT account.wms_id, account.is_active, account.first_name, account.last_name, account.password, account.phone, account.is_pass_change_needed, account.code, account.date_created, account.linked_delivery_point_id, account.patronymic, account.zone_id, account.role_wms_id, account.warehouse_id, account.barcode, account.cell_key, account.jobtitle, account.pinfl 
FROM account 
WHERE account.first_name = %(first_name_1)s AND account.last_name = %(last_name_1)s AND account.barcode = %(barcode_1)s AND account.warehouse_id = %(warehouse_id_1)s ORDER BY random() 
 LIMIT %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 12.07s ago] {'first_name_1': 'Phantom', 'last_name_1': 'Lancer', 'barcode_1': <WMSTestUserStatus.FREE: 'FREE'>, 'warehouse_id_1': 1693627, 'param_1': 1}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT account.wms_id AS account_wms_id, account.is_active AS account_is_active, account.first_name AS account_first_name, account.last_name AS account_last_name, account.password AS account_password, account.phone AS account_phone, account.is_pass_change_needed AS account_is_pass_change_needed, account.code AS account_code, account.date_created AS account_date_created, account.linked_delivery_point_id AS account_linked_delivery_point_id, account.patronymic AS account_patronymic, account.zone_id AS account_zone_id, account.role_wms_id AS account_role_wms_id, account.warehouse_id AS account_warehouse_id, account.barcode AS account_barcode, account.cell_key AS account_cell_key, account.jobtitle AS account_jobtitle, account.pinfl AS account_pinfl 
FROM account 
WHERE account.wms_id = %(pk_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 12.07s ago] {'pk_1': 100290}
INFO     sqlalchemy.engine.Engine:base.py:1846 UPDATE account SET barcode=%(barcode)s WHERE account.wms_id = %(wms_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 12.07s ago] {'barcode': <WMSTestUserStatus.TAKEN: 'TAKEN'>, 'wms_id_1': 100290}
INFO     sqlalchemy.engine.Engine:base.py:1846 INSERT INTO cell (key, zone_id, cell_picking_type, barcode, old_barcode, height, length, width, placing_order, picking_order, inventory_task_id, last_inventory_date, last_inventory_worker_id, deactivate_reason) VALUES (%(key)s, %(zone_id)s, %(cell_picking_type)s, %(barcode)s, %(old_barcode)s, %(height)s, %(length)s, %(width)s, %(placing_order)s, %(picking_order)s, %(inventory_task_id)s, %(last_inventory_date)s, %(last_inventory_worker_id)s, %(deactivate_reason)s) RETURNING cell.id, cell.active, cell.mix_type, cell.skus_amount
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 12s ago] {'key': 'QA-70204077264738816', 'zone_id': <WMSZoneIds.QA_UZ_ZONE: 31>, 'cell_picking_type': <AvailabilityCellPickingType.PICKUP: 'PICKUP'>, 'barcode': None, 'old_barcode': '2026-02-04T11:21:17.264749', 'height': None, 'length': None, 'width': None, 'placing_order': None, 'picking_order': None, 'inventory_task_id': None, 'last_inventory_date': None, 'last_inventory_worker_id': None, 'deactivate_reason': None}
INFO     sqlalchemy.engine.Engine:base.py:2716 COMMIT using DBAPI connection.commit(), has no effect due to autocommit mode
INFO     sqlalchemy.engine.Engine:base.py:2710 BEGIN (implicit; DBAPI should not BEGIN due to autocommit mode)
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT cell.id AS cell_id, cell.key AS cell_key, cell.zone_id AS cell_zone_id, cell.active AS cell_active, cell.mix_type AS cell_mix_type, cell.skus_amount AS cell_skus_amount, cell.cell_picking_type AS cell_cell_picking_type, cell.barcode AS cell_barcode, cell.old_barcode AS cell_old_barcode, cell.height AS cell_height, cell.length AS cell_length, cell.width AS cell_width, cell.placing_order AS cell_placing_order, cell.picking_order AS cell_picking_order, cell.inventory_task_id AS cell_inventory_task_id, cell.last_inventory_date AS cell_last_inventory_date, cell.last_inventory_worker_id AS cell_last_inventory_worker_id, cell.deactivate_reason AS cell_deactivate_reason 
FROM cell 
WHERE cell.id = %(pk_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.99s ago] {'pk_1': 479573}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT invoice.invoice_number, invoice.invoice_status 
FROM shaded_id JOIN sku ON shaded_id.id = sku.shaded_id_id JOIN barcode_info ON sku.id = barcode_info.sku_id JOIN cart_item ON barcode_info.id = cart_item.barcode_info_id JOIN cart ON cart.id = cart_item.cart_id JOIN invoice ON invoice.id = cart.invoice_id 
WHERE shaded_id.external IN (%(external_1_1)s)
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.97s ago] {'external_1_1': 76605129423939}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT shaded_id.external AS external_sku_id, shaded_id.internal AS internal_sku_id, barcode_info.barcode, sku.name, sku_picture.url, CAST(sku.purchase_price AS FLOAT) AS purchase_price, cart_item.quantity, cart_item.currency 
FROM sku LEFT OUTER JOIN shaded_id ON sku.shaded_id_id = shaded_id.id LEFT OUTER JOIN barcode_info ON sku.id = barcode_info.sku_id LEFT OUTER JOIN sku_picture ON sku.id = sku_picture.sku_id LEFT OUTER JOIN cart_item ON barcode_info.id = cart_item.barcode_info_id 
WHERE shaded_id.external IN (%(external_1_1)s)
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.97s ago] {'external_1_1': 76605129423939}
INFO     src.framework.common.api:api.py:97 {"timestamp": "2026-02-04T11:21:17.992800", "type": "request", "method": "POST", "url": "https://dm-ff-be-service-stock.k8s-review.dailymail-tech.uz/qa-api/v1/pull-stock-records", "headers": {"x-aer-mock-hub": "true", "x-aer-mock-lp": "true", "x-aer-mock-ff": "true", "x-aer-mock-yandex-bond": "true", "x-aer-mock-egov-uz": "true", "x-aer-mock-tmg": "true", "Authorization": "Bearer 48f90f11-aaf1-4a1c-b6ec-51a3d9c42ddd"}, "params": {"internalIds": 4100000000000042514}}
INFO     src.framework.common.api:api.py:121 {"timestamp": "2026-02-04T11:21:18.033881", "type": "response", "method": "POST", "url": "https://dm-ff-be-service-stock.k8s-review.dailymail-tech.uz/qa-api/v1/pull-stock-records?internalIds=4100000000000042514", "status_code": 200, "trace_id": null, "headers": {}, "body": "[{\"id\":\"null_4100000000000042514_1693627\",\"internalSkuId\":4100000000000042514,\"externalSkuId\":76605129423939,\"barcode\":null,\"provider\":\"YA\",\"quantityActive\":0,\"quantityPending\":0,\"quantityOverage\":0,\"quantityUnknown\":0,\"quantityDefected\":0,\"quantityMissing\":0,\"warehouseId\":1693627,\"synchronized\":false,\"synchronizedTime\":\"2026-02-04T16:21:18.030+05:00\",\"showcaseQuantity\":0}]", "elapsed_time": 0.039796, "reason": "OK"}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT stock.id, stock.internal_sku_id, stock.external_sku_id, stock.provider, stock.quantity_active, stock.quantity_pending, stock.quantity_overage, stock.quantity_unknown, stock.quantity_defected, stock.quantity_missing, stock.warehouse_id, stock.synchronized, stock.synchronized_time, stock.barcode 
FROM stock 
WHERE stock.internal_sku_id = %(internal_sku_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.95s ago] {'internal_sku_id_1': 4100000000000042514}
INFO     sqlalchemy.engine.Engine:base.py:1846 UPDATE stock SET quantity_active=%(quantity_active)s WHERE stock.internal_sku_id = %(internal_sku_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.95s ago] {'quantity_active': 3, 'internal_sku_id_1': 4100000000000042514}
INFO     sqlalchemy.engine.Engine:base.py:1846 UPDATE batch SET invoice_document_number=%(invoice_document_number)s, invoice_document_date=%(invoice_document_date)s WHERE batch.invoice_id = %(invoice_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.96s ago] {'invoice_document_number': 'autotest_20260204_455', 'invoice_document_date': '2026-02-04 00:00:00.000000', 'invoice_id_1': '410000008158'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT zone.id, zone.key, zone.sort_key, zone.warehouse_id, zone.zone_stock_type, zone.for_global_inventory, zone.action, zone.activated, zone.creation_date, zone.deactivation_reason, zone.disable_date, zone.pattern, zone.title, zone.last_editor_id, zone.action_id 
FROM zone JOIN cell ON cell.zone_id = zone.id 
WHERE cell.key = %(key_1)s AND zone.warehouse_id = %(warehouse_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.95s ago] {'key_1': 'QA-70204077264738816', 'warehouse_id_1': 1693627}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT batch.id, batch.batch_number, batch.sku_id, batch.barcode, batch.warehouse_id, batch.invoice_id, batch.is_return, batch.invoice_barcode, batch.invoice_date_created, batch.invoice_date_placed, batch.date_production, batch.date_expired, batch.shelf_life, batch.purchase_price, batch.sell_price, batch.vat, batch.invoice_document_number, batch.currency, batch.invoice_document_date 
FROM batch 
WHERE batch.sku_id = %(sku_id_1)s AND batch.barcode = %(barcode_1)s AND batch.invoice_id = %(invoice_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.95s ago] {'sku_id_1': 4100000000000042514, 'barcode_1': '6951031994', 'invoice_id_1': '410000008158'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT stock.id, stock.internal_sku_id, stock.external_sku_id, stock.provider, stock.quantity_active, stock.quantity_pending, stock.quantity_overage, stock.quantity_unknown, stock.quantity_defected, stock.quantity_missing, stock.warehouse_id, stock.synchronized, stock.synchronized_time, stock.barcode 
FROM stock 
WHERE stock.internal_sku_id = %(internal_sku_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 12.51s ago] {'internal_sku_id_1': 4100000000000042514}
INFO     sqlalchemy.engine.Engine:base.py:2710 BEGIN (implicit; DBAPI should not BEGIN due to autocommit mode)
INFO     sqlalchemy.engine.Engine:base.py:1846 UPDATE task SET worker_id=%(worker_id)s, worker_name=%(worker_name)s WHERE task.worker_id = %(worker_id_1)s AND task.task_status != %(task_status_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 11.9s ago] {'worker_id': 0, 'worker_name': '0', 'worker_id_1': 100290, 'task_status_1': <MovementTaskStatus.COMPLETED: 'COMPLETED'>}
INFO     sqlalchemy.engine.Engine:base.py:2716 COMMIT using DBAPI connection.commit(), has no effect due to autocommit mode
INFO     sqlalchemy.engine.Engine:base.py:1846 select pg_catalog.version()
INFO     sqlalchemy.engine.Engine:base.py:1846 [raw sql] {}
INFO     sqlalchemy.engine.Engine:base.py:1846 select current_schema()
INFO     sqlalchemy.engine.Engine:base.py:1846 [raw sql] {}
INFO     sqlalchemy.engine.Engine:base.py:1846 show standard_conforming_strings
INFO     sqlalchemy.engine.Engine:base.py:1846 [raw sql] {}
INFO     sqlalchemy.engine.Engine:base.py:2710 BEGIN (implicit; DBAPI should not BEGIN due to autocommit mode)
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT sku_barcode_cell_info.id, sku_barcode_cell_info.amount, sku_barcode_cell_info.barcode, sku_barcode_cell_info.cell_barcode, sku_barcode_cell_info.is_send_to_ff, sku_barcode_cell_info.sku_id, sku_barcode_cell_info.status, sku_barcode_cell_info.type_overage, sku_barcode_cell_info.warehouse_id, sku_barcode_cell_info.invoice_id, sku_barcode_cell_info.invoice_barcode, sku_barcode_cell_info.batch_number, sku_barcode_cell_info.placement_task_id, sku_barcode_cell_info.inventory_task_id, sku_barcode_cell_info.movement_task_id, sku_barcode_cell_info.stock_return_task_id, sku_barcode_cell_info.dm_code, sku_barcode_cell_info.utilization_task_id, sku_barcode_cell_info.date_expired, sku_barcode_cell_info.batch_date_placed, sku_barcode_cell_info.should_be_sent_to_ff, sku_barcode_cell_info.date_created 
FROM sku_barcode_cell_info JOIN placement_task ON sku_barcode_cell_info.placement_task_id = placement_task.id 
WHERE sku_barcode_cell_info.sku_id = %(sku_id_1)s AND sku_barcode_cell_info.barcode = %(barcode_1)s AND sku_barcode_cell_info.cell_barcode = %(cell_barcode_1)s AND placement_task.movement_task_id = %(movement_task_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [generated in 0.00016s] {'sku_id_1': 4100000000000042514, 'barcode_1': '6951031994', 'cell_barcode_1': <MissingCells.NF_1_03_03_3_03: 'NF-1-03-03-3-03'>, 'movement_task_id_1': 31177}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT barcode_info.id, barcode_info.barcode, barcode_info.quantity_active, barcode_info.quantity_pending, barcode_info.warehouse_id, barcode_info.sku_id, barcode_info.quantity_movement 
FROM barcode_info 
WHERE barcode_info.sku_id = %(sku_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 7.984s ago] {'sku_id_1': 4100000000000042514}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT stock.id, stock.internal_sku_id, stock.external_sku_id, stock.provider, stock.quantity_active, stock.quantity_pending, stock.quantity_overage, stock.quantity_unknown, stock.quantity_defected, stock.quantity_missing, stock.warehouse_id, stock.synchronized, stock.synchronized_time, stock.barcode 
FROM stock 
WHERE stock.internal_sku_id = %(internal_sku_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 12.89s ago] {'internal_sku_id_1': 4100000000000042514}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT stock.id, stock.internal_sku_id, stock.external_sku_id, stock.provider, stock.quantity_active, stock.quantity_pending, stock.quantity_overage, stock.quantity_unknown, stock.quantity_defected, stock.quantity_missing, stock.warehouse_id, stock.synchronized, stock.synchronized_time, stock.barcode 
FROM stock 
WHERE stock.internal_sku_id = %(internal_sku_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 15.89s ago] {'internal_sku_id_1': 4100000000000042514}
INFO     sqlalchemy.engine.Engine:base.py:1846 UPDATE account SET barcode=%(barcode)s WHERE account.wms_id = %(wms_id_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 16.82s ago] {'barcode': <WMSTestUserStatus.FREE: 'FREE'>, 'wms_id_1': 100290}