INFO     src.framework.common.api:api.py:97 {"timestamp": "2026-02-08T23:39:59.117388", "type": "request", "method": "POST", "url": "https://dm-fmcg-be-facade-fe.k8s-review.dailymail-tech.uz/api/v1/oauth/custom/token", "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", "x-aer-mesh": "dm-hub-service-package:master;dm-hub-service-package-external:master;dm-hub-service-sorting:master;dm-hub-service-asn:master;dm-hub-service-inbound:master;dm-hub-service-meta:master;dm-hub-service-configuration:master;dm-hub-service-packing:master;dm-hub-service-dispatch:master;dm-hub-service-label:master;dm-hub-service-storage:master;dm-hub-service-cargo:master;dm-hub-service-country:master;dm-hub-service-customs:master;dm-hub-service-document:master;dm-hub-service-email:master;dm-hub-service-file-storage:master;dm-hub-service-inspection:master;dm-hub-service-osl:master;dm-hub-service-partners:master;dm-hub-service-report:master;dm-hub-service-settings:master;dm-hub-service-short-link:master;dm-hub-service-templates:master;dm-hub-service-tracking:master;dm-hub-service-transliteration:master;dm-hub-service-processing:master;dm-hub-api-cargo-carrier:master;dm-hub-api-fe:master;dm-hub-api-ff:master;dm-hub-api-wms:master;dm-hub-api-aer:master;dm-hub-api-joom:master;dm-hub-api-gateway:master;dm-hub-api-partners:master;dm-hub-api-pochta-global:master;dm-hub-api-public:master;dm-hub-api-wildberries:master;dm-hub-api-internal:master;dm-hub-daemon-package-process:master;dm-hub-daemon-tracking:master;dm-hub-integration-ff:master;dm-hub-integration-aer:master;dm-hub-integration-cainiao:master;dm-hub-integration-cargo-carrier:master;dm-hub-integration-gtt:master;dm-hub-integration-kazpost:master;dm-hub-integration-kgpost:master;dm-hub-integration-partners:master;dm-hub-integration-post:master;dm-hub-integration-rupost:master;dm-hub-integration-telegram:master;dm-hub-integration-upu:master;dm-hub-integration-wms:master;dm-hub-workflow-asn:master;dm-hub-workflow-email:master;dm-hub-workflow-hub-external:master;dm-hub-workflow-hub-internal:master;dm-hub-workflow-integration:master;dm-hub-workflow-package:master;dm-hub-workflow-tracking:master;dm-hub-workflow-hub-internal:master;dm-hub-service-packing:master;dm-hub-service-cargo:master;dm-hub-workflow-hub-external:master"}, "json": {"login": "9000000001", "password": "1234", "grantType": "password"}}
INFO     src.framework.common.api:api.py:121 {"timestamp": "2026-02-08T23:39:59.148212", "type": "response", "method": "POST", "url": "https://dm-fmcg-be-facade-fe.k8s-review.dailymail-tech.uz/api/v1/oauth/custom/token", "status_code": 200, "trace_id": "f53ae0d707c4f635bb667835bad53942", "headers": {}, "body": "{\"token\":\"859c9013-55b3-4eda-9204-a8ce5c82e226\",\"expired\":false,\"refreshToken\":\"6a2123c0-5851-4a4c-b9ad-e4ec53ae62a8\",\"expiresIn\":100748,\"expiration\":\"2026-02-10T03:39:07.146+00:00\"}", "elapsed_time": 0.029539, "reason": "OK"}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT cell.id, cell.zone_id, cell.cell_barcode, cell.is_active, cell.type, cell.create_at, cell.update_at 
FROM cell 
WHERE cell.cell_barcode = %(cell_barcode_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 18.2s ago] {'cell_barcode_1': 'QA_AUTOTEST_CELL_70593999149302272'}
INFO     sqlalchemy.engine.Engine:base.py:1846 INSERT INTO cell (zone_id, cell_barcode, is_active, type) VALUES (%(zone_id)s, %(cell_barcode)s, %(is_active)s, %(type)s) RETURNING cell.id
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 18.2s ago] {'zone_id': 2, 'cell_barcode': 'QA_AUTOTEST_CELL_70593999149302272', 'is_active': True, 'type': <StockCellType.STORAGE: 'STORAGE'>}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT cell.id, cell.zone_id, cell.cell_barcode, cell.is_active, cell.type, cell.create_at, cell.update_at 
FROM cell 
WHERE cell.cell_barcode = %(cell_barcode_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 18.2s ago] {'cell_barcode_1': 'QA_AUTOTEST_CELL_70593999149302272'}
INFO     kafka.conn:conn.py:400 <BrokerConnection client_id=kafka-python-producer-4, node_id=bootstrap-0 host=redpanda.redpanda-operator.svc:9092 <connecting> [IPv4 ('10.100.174.31', 9092)]>: connecting to redpanda.redpanda-operator.svc:9092 [('10.100.174.31', 9092) IPv4]
INFO     kafka.conn:conn.py:622 <BrokerConnection client_id=kafka-python-producer-4, node_id=bootstrap-0 host=redpanda.redpanda-operator.svc:9092 <checking_api_versions_recv> [IPv4 ('10.100.174.31', 9092)]>: Broker version identified as 2.6
INFO     kafka.conn:conn.py:461 <BrokerConnection client_id=kafka-python-producer-4, node_id=bootstrap-0 host=redpanda.redpanda-operator.svc:9092 <connected> [IPv4 ('10.100.174.31', 9092)]>: Connection complete.
INFO     kafka.conn:conn.py:400 <BrokerConnection client_id=kafka-python-producer-4, node_id=2 host=redpanda-2.redpanda.redpanda-operator.svc.cluster.local.:9092 <connecting> [IPv4 ('10.100.180.5', 9092)]>: connecting to redpanda-2.redpanda.redpanda-operator.svc.cluster.local.:9092 [('10.100.180.5', 9092) IPv4]
INFO     kafka.conn:conn.py:461 <BrokerConnection client_id=kafka-python-producer-4, node_id=2 host=redpanda-2.redpanda.redpanda-operator.svc.cluster.local.:9092 <connected> [IPv4 ('10.100.180.5', 9092)]>: Connection complete.
INFO     kafka.conn:conn.py:951 <BrokerConnection client_id=kafka-python-producer-4, node_id=bootstrap-0 host=redpanda.redpanda-operator.svc:9092 <connected> [IPv4 ('10.100.174.31', 9092)]>: Closing connection. 
INFO     kafka.conn:conn.py:400 <BrokerConnection client_id=kafka-python-producer-4, node_id=0 host=redpanda-0.redpanda.redpanda-operator.svc.cluster.local.:9092 <connecting> [IPv4 ('10.100.174.31', 9092)]>: connecting to redpanda-0.redpanda.redpanda-operator.svc.cluster.local.:9092 [('10.100.174.31', 9092) IPv4]
INFO     kafka.conn:conn.py:461 <BrokerConnection client_id=kafka-python-producer-4, node_id=0 host=redpanda-0.redpanda.redpanda-operator.svc.cluster.local.:9092 <connected> [IPv4 ('10.100.174.31', 9092)]>: Connection complete.
INFO     kafka.conn:conn.py:951 <BrokerConnection client_id=kafka-python-producer-4, node_id=2 host=redpanda-2.redpanda.redpanda-operator.svc.cluster.local.:9092 <connected> [IPv4 ('10.100.180.5', 9092)]>: Closing connection. 
INFO     kafka.conn:conn.py:951 <BrokerConnection client_id=kafka-python-producer-4, node_id=0 host=redpanda-0.redpanda.redpanda-operator.svc.cluster.local.:9092 <connected> [IPv4 ('10.100.174.31', 9092)]>: Closing connection. 
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 54.75s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 56.76s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 58.76s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 60.76s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 62.76s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 64.77s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 66.77s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 68.77s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 70.77s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}
INFO     sqlalchemy.engine.Engine:base.py:1846 SELECT inbox.id, inbox.topic, inbox.payload, inbox.status, inbox.retry_count, inbox.max_retry_count, inbox.key, inbox.headers, inbox.created_at, inbox.next_retry_at, inbox.processing_started_at, inbox.error_message, inbox.exception_stack_trace, inbox.processing_node, inbox.processing_timeout_minutes 
FROM inbox 
WHERE inbox.topic = %(topic_1)s AND CAST(inbox.payload AS VARCHAR) LIKE %(param_1)s
INFO     sqlalchemy.engine.Engine:base.py:1846 [cached since 72.78s ago] {'topic_1': <KafkaTopics.fmcg_invoice_create: 'fmcg_invoice_create'>, 'param_1': '%70593999149277440%'}