Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Sandbox: fills are applied multiple times to the same limit order #1639

Closed
davidsblom opened this issue May 12, 2024 · 10 comments · Fixed by #1642
Closed

Sandbox: fills are applied multiple times to the same limit order #1639

davidsblom opened this issue May 12, 2024 · 10 comments · Fixed by #1642
Assignees
Labels
bug Something isn't working

Comments

@davidsblom
Copy link
Collaborator

Bug Report

Expected Behavior

Only 1 fill is created for the limit order client_order_id=O-20240511-1933-001-000-3601.

Actual Behavior

During a sandbox live trading test, multiple fill events are created for an existing limit order.

2024-05-11T19:33:10.736953001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, side=BUY, type=LIMIT, quantity=0.003, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '61082.56', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-11T19:33:10.737487001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=None, position_id=None, tags=None)
2024-05-11T19:33:10.737506001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-11T19:33:10.738953001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send sell order
2024-05-11T19:33:10.739038001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderPendingCancel(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3598, venue_order_id=BYBIT-617-2921, account_id=BYBIT-001, ts_event=1715455990738927001)
2024-05-11T19:33:10.739067001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> CancelOrder(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3598, venue_order_id=BYBIT-617-2921)
2024-05-11T19:33:10.739078001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3602, side=SELL, type=LIMIT, quantity=0.002, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '61140.97', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-11T19:33:10.739551001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_140.97 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3602, venue_order_id=None, position_id=None, tags=None)
2024-05-11T19:33:10.739558001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_140.97 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3602, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-11T19:33:10.739566001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.80,0.534,SELLER,661004c5-b796-5952-ba17-47b587518626,1715455990667000064)
2024-05-11T19:33:10.739571001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.80,0.327,SELLER,383c6bf2-d358-5086-9aba-678f10293a74,1715455990667000064)
2024-05-11T19:33:10.739576001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.80,0.327,SELLER,fa1bd2ec-5539-59fb-bd31-d0894bbb0d2c,1715455990667000064)
2024-05-11T19:33:10.739580001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.40,0.020,SELLER,fc1b7724-f1c1-527d-ac2b-30928c94249c,1715455990667000064)
2024-05-11T19:33:10.739584001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.40,0.033,SELLER,ebbac449-4f75-5996-8c5c-bc6d012c6f62,1715455990667000064)
2024-05-11T19:33:10.739588001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.40,0.327,SELLER,2b782b8d-53dc-5850-b741-5cc2fd411015,1715455990667000064)
2024-05-11T19:33:10.739592001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.30,0.010,SELLER,8116fd09-f34c-5179-9678-4a63a4ff009d,1715455990667000064)
2024-05-11T19:33:10.739596001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.30,0.025,SELLER,9aa09a2f-ce3a-5f97-a7e5-c2fd61fd45dd,1715455990667000064)
2024-05-11T19:33:10.739600001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.30,0.033,SELLER,47a929dd-dca7-5b06-a182-9366143a32bb,1715455990667000064)
2024-05-11T19:33:10.739604001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.30,0.327,SELLER,34a62efd-26b1-5037-85b9-4353513309f6,1715455990667000064)
2024-05-11T19:33:10.739608001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.20,0.025,SELLER,c5071ed2-af5b-54b3-aa1a-0695db6aeb2d,1715455990667000064)
2024-05-11T19:33:10.739611001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.20,0.082,SELLER,ec61bc5c-2b9a-5b32-9380-a45d044cdfd0,1715455990667000064)
2024-05-11T19:33:10.739615001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.20,0.001,SELLER,5af41b4e-65af-5b01-89ae-f7b08e4738bf,1715455990667000064)
2024-05-11T19:33:10.739619001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.20,0.012,SELLER,2646fa84-8a75-5466-8a8f-bc35498537e0,1715455990667000064)
2024-05-11T19:33:10.739623001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.10,0.002,SELLER,dacedea5-d390-5a1d-abfd-7dbb1cf13b6d,1715455990667000064)
2024-05-11T19:33:10.739627001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.00,0.327,SELLER,d337549f-7f04-5d28-b950-98084c35df42,1715455990667000064)
2024-05-11T19:33:10.739630001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.00,0.043,SELLER,712e9be2-b1a6-5c17-b2ab-484ec6a1f18d,1715455990667000064)
2024-05-11T19:33:10.739634001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderSubmitted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, account_id=BYBIT-001, ts_event=1715455990734621001)
2024-05-11T19:33:10.739640001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderSubmitted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3602, account_id=BYBIT-001, ts_event=1715455990734621001)
2024-05-11T19:33:10.744793001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61090.90,0.005,SELLER,50adc616-7e0b-5793-a408-a5ac898661db,1715455990671000064)
2024-05-11T19:33:10.746035001Z [DEBUG] PAPER-TRADING-001.Cache: Indexed ClientOrderId('O-20240511-1933-001-000-3601') with VenueOrderId('BYBIT-617-2923')
2024-05-11T19:33:10.746098001Z [DEBUG] PAPER-TRADING-001.Cache: Indexed ClientOrderId('O-20240511-1933-001-000-3602') with VenueOrderId('BYBIT-617-2924')
2024-05-11T19:33:10.746121001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61090.40,0.001,SELLER,3b852a92-6afd-55db-a974-d316610d1d13,1715455990672000000)
2024-05-11T19:33:10.746129001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61090.40,0.111,SELLER,1d483bf5-fe52-5838-ae4e-38e685876bea,1715455990673999872)
2024-05-11T19:33:10.746138001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61090.10,0.112,SELLER,52545b3b-1acd-5ed8-b96f-5e7128b0be11,1715455990673999872)
2024-05-11T19:33:10.748459001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61089.90,0.005,SELLER,1a88d076-49cd-52b8-a77f-18243ef51768,1715455990673999872)
2024-05-11T19:33:10.748473001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61089.20,0.112,SELLER,663a8be5-2e96-53a0-85d1-594edcfd1a6d,1715455990673999872)
2024-05-11T19:33:10.748480001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61088.90,0.112,SELLER,0d8ade49-a1e2-5b50-89fb-7dd25139a96d,1715455990673999872)
2024-05-11T19:33:10.748487001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61088.10,0.112,SELLER,df6bcc5f-2bc9-50c1-977d-275507eff95e,1715455990673999872)
2024-05-11T19:33:10.748493001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61087.40,0.112,SELLER,4d3a8af6-4063-51dd-b55a-4490b7d41d26,1715455990673999872)
2024-05-11T19:33:10.748510001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61087.00,0.112,SELLER,6f839b03-cb33-598b-98f9-5be7008d6f61,1715455990673999872)
2024-05-11T19:33:10.748515001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.00,0.039,SELLER,032c0148-cfe9-5668-a68f-67915c017f6f,1715455990673999872)
2024-05-11T19:33:10.748520001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61085.00,0.082,SELLER,607c47ee-58f8-5bfb-be05-a81f1037bcd3,1715455990673999872)
2024-05-11T19:33:10.748524001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.90,0.018,SELLER,7531ab11-bcdb-5947-9a68-f3f3e8aa6f29,1715455990673999872)
2024-05-11T19:33:10.748528001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.90,0.028,SELLER,7bd357fc-2a56-53ac-aa63-68b4aee781f2,1715455990673999872)
2024-05-11T19:33:10.748532001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.80,0.001,SELLER,759cf257-ed00-520b-b5d2-c12aa6c2534d,1715455990673999872)
2024-05-11T19:33:10.748536001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.80,0.116,SELLER,befae625-21a0-5cc2-84f7-f1b4f4ffee16,1715455990673999872)
2024-05-11T19:33:10.748608001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=12.36330000 USDT
2024-05-11T19:33:10.748626001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97550000 USDT, locked=37.00710000 USDT, free=999_962.96840000 USDT)], margins=[MarginBalance(initial=12.36330000 USDT, maintenance=24.64380000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=380a69ae-2135-47d5-9683-81dc4fc49aa1)
2024-05-11T19:33:10.748634001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3599, venue_order_id=BYBIT-617-2922, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.748638001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3599, venue_order_id=BYBIT-617-2922, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.748645001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=0.0000 USDT
2024-05-11T19:33:10.748658001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97550000 USDT, locked=24.64380000 USDT, free=999_975.33170000 USDT)], margins=[MarginBalance(initial=0.00000000 USDT, maintenance=24.64380000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=191f8a3d-2529-4cdf-8fe4-06b42f832a4f)
2024-05-11T19:33:10.749024001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3598, venue_order_id=BYBIT-617-2921, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.749042001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3598, venue_order_id=BYBIT-617-2921, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.749073001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=18.52630000 USDT
2024-05-11T19:33:10.749090001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97550000 USDT, locked=43.17010000 USDT, free=999_956.80540000 USDT)], margins=[MarginBalance(initial=18.52630000 USDT, maintenance=24.64380000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=105e7a5c-10c1-4b27-b1fc-5b41b1a870b4)
2024-05-11T19:33:10.749347001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.749364001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.749389001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=30.88900000 USDT
2024-05-11T19:33:10.749417001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97550000 USDT, locked=55.53280000 USDT, free=999_944.44270000 USDT)], margins=[MarginBalance(initial=30.88900000 USDT, maintenance=24.64380000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=5b5e3086-8ae8-423e-a5aa-368fb66b6dd7)
2024-05-11T19:33:10.749431001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3602, venue_order_id=BYBIT-617-2924, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.749438001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3602, venue_order_id=BYBIT-617-2924, account_id=BYBIT-001, ts_event=1715455990744624001)
2024-05-11T19:33:10.765996001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.80,0.080,SELLER,e24eac59-9d9e-55e4-99de-11e0dee2e40c,1715455990675000064)
2024-05-11T19:33:10.766042001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.70,0.006,SELLER,16badac1-42d1-5405-a3ee-241f04381dc4,1715455990675000064)
2024-05-11T19:33:10.766052001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.70,0.017,SELLER,7ff45608-0ec6-5289-99f2-dbf2cf54672e,1715455990675000064)
2024-05-11T19:33:10.766057001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.70,0.327,SELLER,7eccf16d-88a7-5ba2-868c-c896ea6956d7,1715455990675000064)
2024-05-11T19:33:10.766062001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.70,0.327,SELLER,1c87c330-23e0-57f5-8ec7-524a8bedb8f0,1715455990675000064)
2024-05-11T19:33:10.766066001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.70,0.012,SELLER,a79f2ecd-23e4-5f43-99c7-2884375c157f,1715455990675000064)
2024-05-11T19:33:10.766071001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.50,0.327,SELLER,c48bfca8-0b1f-5e68-a807-01f3d9ea20aa,1715455990675000064)
2024-05-11T19:33:10.766077001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.40,0.006,SELLER,a34295db-5ae7-5334-b4c0-fe92a67ae805,1715455990675000064)
2024-05-11T19:33:10.766081001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.40,0.327,SELLER,00447d7c-ac84-5999-b6e0-cfe2c0f5468e,1715455990675000064)
2024-05-11T19:33:10.766085001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.30,0.005,SELLER,d93145e7-c69d-5182-ab91-2025a4f1073d,1715455990675000064)
2024-05-11T19:33:10.766089001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.30,0.082,SELLER,6273737c-b8bc-531e-b241-9e37ddb59273,1715455990675000064)
2024-05-11T19:33:10.766093001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.10,0.163,SELLER,12ca34de-032b-5832-9094-3303d469b902,1715455990675000064)
2024-05-11T19:33:10.766097001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.10,0.164,SELLER,88ddc1b8-0fde-5b2d-95d2-36a02c59059f,1715455990675000064)
2024-05-11T19:33:10.766101001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.10,0.327,SELLER,c6ccfa75-2dd9-57ce-a5fd-e835a2b305bd,1715455990675000064)
2024-05-11T19:33:10.766115001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.00,0.327,SELLER,75ae9d04-51e6-5ff3-992f-fbe8ea80c6ff,1715455990675000064)
2024-05-11T19:33:10.766186001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.00,0.012,SELLER,a7964bc8-4545-5dd3-bd5f-a01990dbdeb3,1715455990675000064)
2024-05-11T19:33:10.766211001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.80,0.015,SELLER,3f06426a-b16c-50f2-b312-5eea2deda06b,1715455990675000064)
2024-05-11T19:33:10.766216001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.80,0.513,SELLER,297779a7-bf66-55d8-a217-8ed14a9bd54e,1715455990675000064)
2024-05-11T19:33:10.766220001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.80,0.237,SELLER,e2798e8f-801b-5f6e-b9e9-647ced99483e,1715455990676000000)
2024-05-11T19:33:10.766223001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.70,0.002,SELLER,e9fe7e89-748e-51ee-a759-a25e3ce6721c,1715455990676000000)
2024-05-11T19:33:10.766227001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.70,0.025,SELLER,d6d5010c-0306-55d1-8dcc-4462eb5306d8,1715455990676000000)
2024-05-11T19:33:10.766231001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.70,0.011,SELLER,e72b50b2-7bc8-5cbe-a9be-5b76cb6b221c,1715455990676000000)
2024-05-11T19:33:10.766234001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61085.00,61084.80,0.504,0.300,1715455990680000000)
2024-05-11T19:33:10.766243001Z [DEBUG] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [0.1221698, 0.1852920579050926, -0.02, 0.2537313432835821, -0.002, 1.3730440633861682, 0.3864537726157862]
2024-05-11T19:33:10.766611001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send buy order
2024-05-11T19:33:10.766631001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderPendingCancel(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, ts_event=1715455990766606001)
2024-05-11T19:33:10.766647001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> CancelOrder(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923)
2024-05-11T19:33:10.766678001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3603, side=BUY, type=LIMIT, quantity=0.003, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '61060.57', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-11T19:33:10.767105001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_060.57 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3603, venue_order_id=None, position_id=None, tags=None)
2024-05-11T19:33:10.767110001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_060.57 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3603, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-11T19:33:10.767119001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send sell order
2024-05-11T19:33:10.767126001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderPendingCancel(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3602, venue_order_id=BYBIT-617-2924, account_id=BYBIT-001, ts_event=1715455990766717001)
2024-05-11T19:33:10.767281001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> CancelOrder(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3602, venue_order_id=BYBIT-617-2924)
2024-05-11T19:33:10.767289001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3604, side=SELL, type=LIMIT, quantity=0.002, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '61133.67', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-11T19:33:10.767302001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_133.67 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3604, venue_order_id=None, position_id=None, tags=None)
2024-05-11T19:33:10.767307001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_133.67 GTC, status=INITIALIZED, client_order_id=O-20240511-1933-001-000-3604, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-11T19:33:10.767482001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61084.50,0.005,SELLER,f1537172-e24d-5028-a07b-a9b704db3f6c,1715455990680000000)
2024-05-11T19:33:10.767487001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.70,0.014,SELLER,36867bc7-ea98-55a6-9299-f45e7927bad1,1715455990680000000)
2024-05-11T19:33:10.767492001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.70,0.006,SELLER,42dd6d39-e347-58fb-a0ae-009a2a76d66f,1715455990680000000)
2024-05-11T19:33:10.767497001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.50,0.025,SELLER,22ee2783-b2d0-50ad-9cb2-87a7c9f5ba62,1715455990683000064)
2024-05-11T19:33:10.767502001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61083.20,0.033,SELLER,9ba217e2-5c6a-537f-aac9-960574485f7c,1715455990684000000)
2024-05-11T19:33:10.767507001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61084.50,61083.60,0.504,1.354,1715455990689999872)
2024-05-11T19:33:10.767512001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.70,0.002,SELLER,a07382db-18a7-5fc8-bf33-e606d018ee7a,1715455990691000064)
2024-05-11T19:33:10.767515001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.20,0.002,SELLER,dcce1a92-ca66-563c-8a6a-26aecca3a270,1715455990691000064)
2024-05-11T19:33:10.785146001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.002))]
2024-05-11T19:33:10.792170001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.00,0.012,SELLER,631d5206-add4-5cdf-93f5-08952a9f70d8,1715455990691000064)
2024-05-11T19:33:10.793867001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.793917001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.00,0.009,SELLER,26608c02-8629-5eac-b40a-bff98bd4e9cd,1715455990691000064)
2024-05-11T19:33:10.793936001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.793959001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.00,0.033,SELLER,0029459a-e005-589a-b19a-39d7f871ced2,1715455990692000000)
2024-05-11T19:33:10.795948001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.795973001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.00,0.037,SELLER,3901e65d-eac9-54e3-aa1b-c29e431c1a2e,1715455990692999936)
2024-05-11T19:33:10.796340001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.796370001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61082.00,0.002,SELLER,0fd8700d-fda9-5b2c-80a8-d0dbe53d8860,1715455990692999936)
2024-05-11T19:33:10.798172001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.002))]
2024-05-11T19:33:10.798220001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.90,0.011,SELLER,e6ee82d5-a448-5564-8ea7-ba8ac789d926,1715455990692999936)
2024-05-11T19:33:10.800659001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.800694001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.90,0.008,SELLER,97b32c9e-d78c-553e-b9cb-3e403bb80c9b,1715455990692999936)
2024-05-11T19:33:10.800979001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.801014001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.90,0.004,SELLER,756c7be8-cf5d-5d25-82e3-6b46f885b4a2,1715455990692999936)
2024-05-11T19:33:10.802744001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.802767001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.90,0.015,SELLER,97475027-1a53-52dd-9786-b421c11f4e15,1715455990694000128)
2024-05-11T19:33:10.802776001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.802805001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.80,0.012,SELLER,f583f232-aafd-5c48-931a-2db820b08c7d,1715455990694000128)
2024-05-11T19:33:10.803127001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.803184001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.70,0.002,SELLER,d6199925-17b1-5ebd-bdad-d3b84683e008,1715455990694000128)
2024-05-11T19:33:10.804779001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.002))]
2024-05-11T19:33:10.804805001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.60,0.008,SELLER,cfe295ae-6e8a-54ce-93c3-30bd3ae14007,1715455990694000128)
2024-05-11T19:33:10.804822001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.804838001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.60,0.020,SELLER,8767dbae-8c43-5546-ba87-8de4b6fbbc77,1715455990696999936)
2024-05-11T19:33:10.805211001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.805264001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.60,0.012,SELLER,51cca90c-1cbc-5809-9445-b545411ca332,1715455990696999936)
2024-05-11T19:33:10.806871001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.807199001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.001,SELLER,06c91433-f111-5f1d-ae09-354e2cbd73a4,1715455990696999936)
2024-05-11T19:33:10.807221001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.001))]
2024-05-11T19:33:10.807256001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61082.70,61081.70,0.504,1.144,1715455990700000000)
2024-05-11T19:33:10.809364001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.809789001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.033,SELLER,bf5d8b4e-7b71-5e50-a42f-41b2522526e4,1715455990702000128)
2024-05-11T19:33:10.811258001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=PENDING_CANCEL, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(61082.56), Quantity(0.003))]
2024-05-11T19:33:10.811313001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.033,SELLER,0021c8fe-f562-5507-b525-53911a778dd4,1715455990704000000)
2024-05-11T19:33:10.811327001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,0.672,3.239,1715455990710000128)
2024-05-11T19:33:10.811356001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.018,SELLER,0e61c68e-5ed3-5f58-905f-177a760251a5,1715455990710000128)
2024-05-11T19:33:10.811363001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.015,SELLER,65272c04-fb0c-5b4a-a6ef-4d08a82a458d,1715455990712000000)
2024-05-11T19:33:10.811368001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.017,SELLER,41faf4e8-a747-5b7f-9689-cee0cab2e436,1715455990712999936)
2024-05-11T19:33:10.811373001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.016,SELLER,aae5bad6-ace6-5428-bd63-332e9c57e660,1715455990712999936)
2024-05-11T19:33:10.811379001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.033,SELLER,877625c0-fcf7-521e-8e31-71bfabc5dfd4,1715455990715000064)
2024-05-11T19:33:10.811396001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.025,SELLER,9fa6a833-a234-513d-89b7-e28903d37ebb,1715455990716000000)
2024-05-11T19:33:10.811424001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.008,SELLER,a6a97822-9008-57e3-a54d-87dacd03bdf8,1715455990716000000)
2024-05-11T19:33:10.811449001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.017,SELLER,23124a25-c641-50fa-a5a9-782aea35fd53,1715455990716000000)
2024-05-11T19:33:10.811456001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.025,SELLER,40c87cdf-e771-5100-a4db-3b79b23972a9,1715455990719000064)
2024-05-11T19:33:10.813254001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,0.893,6.465,1715455990726000128)
2024-05-11T19:33:10.813263001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.025,SELLER,148f9439-a81d-5bd2-b097-353274481473,1715455990720000000)
2024-05-11T19:33:10.813267001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,61081.50,0.025,SELLER,b37bb037-706c-5429-98b5-1fd781e07e6e,1715455990720000000)
2024-05-11T19:33:10.813272001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,1.252,8.340,1715455990729999872)
2024-05-11T19:33:10.813290001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,1.302,7.448,1715455990740000000)
2024-05-11T19:33:10.813296001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,3.715,7.358,1715455990750000128)
2024-05-11T19:33:10.813313001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,3.939,7.133,1715455990760000000)
2024-05-11T19:33:10.813319001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,4.413,6.410,1715455990769999872)
2024-05-11T19:33:10.813335001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,61081.50,61081.60,4.577,6.544,1715455990780000000)
2024-05-11T19:33:10.821460001Z [DEBUG] PAPER-TRADING-001.Portfolio: Calculated PnLs: []
2024-05-11T19:33:10.825898001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_maint=24.64380000 USDT
2024-05-11T19:33:10.825949001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=30.88900000 USDT
2024-05-11T19:33:10.825960001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.95110000 USDT, locked=55.53280000 USDT, free=999_944.41830000 USDT)], margins=[MarginBalance(initial=30.88900000 USDT, maintenance=24.64380000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=27a43894-dbc7-4ae3-8341-1683c6f8c848)
2024-05-11T19:33:10.828398001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderFilled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, trade_id=BYBIT-617-4562, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=BUY, order_type=LIMIT, last_qty=0.002, last_px=61_082.56 USDT, commission=0.0244 USDT, liquidity_side=MAKER, ts_event=1715455990765784001)
2024-05-11T19:33:10.828469001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderFilled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, trade_id=BYBIT-617-4562, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=BUY, order_type=LIMIT, last_qty=0.002, last_px=61_082.56 USDT, commission=0.0244 USDT, liquidity_side=MAKER, ts_event=1715455990765784001)
2024-05-11T19:33:10.839086001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT net_position=0.006
2024-05-11T19:33:10.839223001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_maint=36.92750000 USDT
2024-05-11T19:33:10.839428001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] PositionChanged(instrument_id=BTCUSDT-LINEAR.BYBIT, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, account_id=BYBIT-001, opening_order_id=O-20240511-1849-001-000-1603, closing_order_id=None, entry=BUY, side=LONG, signed_qty=0.006, quantity=0.006, peak_qty=0.006, currency=USDT, avg_px_open=61209.14666666667, avg_px_close=0.0, realized_return=0.00000, realized_pnl=-0.0734 USDT, unrealized_pnl=-0.7595 USDT, ts_opened=1715453388000000000, ts_last=1715455990765784001, ts_closed=0, duration_ns=0)
2024-05-11T19:33:11.011610001Z [ERROR] PAPER-TRADING-001.ExecEngine: Error on applying OrderFilled(trader_id=PAPER-TRADING-001, strategy_id=ReinforcementLearningMarketMakerStrategy-000, instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, trade_id=BYBIT-617-4563, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=BUY, order_type=LIMIT, last_qty=0.003, last_px=61_082.56 USDT, commission=0.0366 USDT, liquidity_side=MAKER, event_id=b88f97ce-91b4-47de-9c40-26e741d138c9, ts_event=1715455990765787001, ts_init=1715455990765787001) to LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 61_082.56 GTC, status=FILLED, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, tags=None)
ValueError(invalid order.leaves_qty: was 18446744073.70755, order.quantity=0.003, order.filled_qty=0.002, fill.last_qty=0.003, fill=OrderFilled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240511-1933-001-000-3601, venue_order_id=BYBIT-617-2923, account_id=BYBIT-001, trade_id=BYBIT-617-4563, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=BUY, order_type=LIMIT, last_qty=0.003, last_px=61_082.56 USDT, commission=0.0366 USDT, liquidity_side=MAKER, ts_event=1715455990765787001))
Traceback (most recent call last):
  File "nautilus_trader/execution/engine.pyx", line 1007, in nautilus_trader.execution.engine.ExecutionEngine._apply_event_to_order
  File "nautilus_trader/model/orders/base.pyx", line 1010, in nautilus_trader.model.orders.base.Order.apply
  File "nautilus_trader/model/orders/base.pyx", line 1063, in nautilus_trader.model.orders.base.Order._filled

2024-05-11T19:33:11.012667001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT net_position=0.009

Steps to Reproduce the Problem

  1. Setup sandbox trading test

Specifications

  • OS platform: MacOS
  • Python version: 3.11.4
  • nautilus_trader version: develop branch, git commit ee47d5e
@davidsblom davidsblom added the bug Something isn't working label May 12, 2024
@davidsblom
Copy link
Collaborator Author

I've pasted the logs specifically for order O-20240511-1933-001-000-3601. I am wondering whether there is some priority queue mechanism in place to process order events ahead of data events? Perhaps multiple ticks are triggering the fills, the fill events are then processed too late when other fill events have already been created.

@cjdsellers
Copy link
Member

Yes, this was also my thought that multiple ticks are triggering fills causing an overfill. Its the same overall cause as the last error, that we now have this real-time component of the system operating outside a deterministic loop.

@cjdsellers cjdsellers self-assigned this May 12, 2024
@cjdsellers cjdsellers added this to In progress in NautilusTrader Kanban Board May 12, 2024
@cjdsellers
Copy link
Member

cjdsellers commented May 12, 2024

Separately, the leaves quantity should never be allowed to underflow like that as well.

[edit] I see what was happening there - it became negative and was then cast to an unsigned int64 in the exception message, so at least the invariant was upheld there.

@davidsblom
Copy link
Collaborator Author

Yes, exactly. We probably need a mechanism that order fills are processed on priority. Not sure how much impact that has on the current code base.

@cjdsellers
Copy link
Member

So the issue here is that a real matching engine would keep track of exactly how much of an order has been filled, where as the backtest matching engine Nautilus uses allows this to be tracked by the order object itself, and execution engine - essentially all "client side". This wasn't a problem just for backtesting, but has become a problem for sandbox mode.

I've added a fill quantity cache to the matching engine now so that once the entire size has "cached/pending" fills, no more fills will be processed even as additional ticks may be arriving before the execution engine has a chance to apply the events ff7c338.

Lets see how this goes.

@davidsblom
Copy link
Collaborator Author

Amazing! Currently compiling and about to start a new test, but won't be able to let it run for a long time. This evening I'll let it run overnight.

@cjdsellers cjdsellers changed the title sandbox: fills are applied multiple times to the same limit order resulting in a ValueError with order.leaves_qty: was 18446744073.70755 Sandbox: fills are applied multiple times to the same limit order May 12, 2024
@davidsblom
Copy link
Collaborator Author

The error hasn't occured during the latest test, so closing. Thanks for making the fix!

@cjdsellers cjdsellers moved this from In progress to Done in NautilusTrader Kanban Board May 13, 2024
@davidsblom
Copy link
Collaborator Author

Reopening as the error occured again. This is on the develop branch with git commit ee1c9b2

2024-05-13T17:36:31.890691001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, side=SELL, type=LIMIT, quantity=0.002, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '62772.15', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-13T17:36:31.890782001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-112, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:31.890851001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-112, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-13T17:36:31.891476001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderSubmitted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-111, account_id=BYBIT-001, ts_event=1715621791887383001)
2024-05-13T17:36:31.891513001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderSubmitted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, account_id=BYBIT-001, ts_event=1715621791887383001)
2024-05-13T17:36:31.898265001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62762.80,62762.90,14.376,3.431,1715621791800000000)
2024-05-13T17:36:31.898413001Z [DEBUG] PAPER-TRADING-001.Cache: Indexed ClientOrderId('O-20240513-1736-001-000-111') with VenueOrderId('BYBIT-617-097')
2024-05-13T17:36:31.898454001Z [DEBUG] PAPER-TRADING-001.Cache: Indexed ClientOrderId('O-20240513-1736-001-000-112') with VenueOrderId('BYBIT-617-098')
2024-05-13T17:36:31.898714001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=12.69220000 USDT
2024-05-13T17:36:31.898807001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97490000 USDT, locked=25.30450000 USDT, free=999_974.67040000 USDT)], margins=[MarginBalance(initial=12.69220000 USDT, maintenance=12.61230000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=102acdfd-1ae9-4649-ab5d-90a00e4e29ac)
2024-05-13T17:36:31.898840001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-109, venue_order_id=BYBIT-617-095, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.898857001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-109, venue_order_id=BYBIT-617-095, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.898880001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=0.0000 USDT
2024-05-13T17:36:31.898898001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97490000 USDT, locked=12.61230000 USDT, free=999_987.36260000 USDT)], margins=[MarginBalance(initial=0.00000000 USDT, maintenance=12.61230000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=e9ae514e-e283-4222-a8e1-ce42b8cdb5c5)
2024-05-13T17:36:31.898919001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-110, venue_order_id=BYBIT-617-096, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.898933001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderCanceled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-110, venue_order_id=BYBIT-617-096, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.899146001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=19.02450000 USDT
2024-05-13T17:36:31.899169001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97490000 USDT, locked=31.63680000 USDT, free=999_968.33810000 USDT)], margins=[MarginBalance(initial=19.02450000 USDT, maintenance=12.61230000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=130a811b-a74f-4138-a83f-dd1cc5b67e56)
2024-05-13T17:36:31.899192001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-111, venue_order_id=BYBIT-617-097, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.899207001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-111, venue_order_id=BYBIT-617-097, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.899227001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=31.71700000 USDT
2024-05-13T17:36:31.899244001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=999_999.97490000 USDT, locked=44.32930000 USDT, free=999_955.64560000 USDT)], margins=[MarginBalance(initial=31.71700000 USDT, maintenance=12.61230000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=a1cbd1d7-b8a0-4d4d-8298-b64928a21985)
2024-05-13T17:36:31.899271001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.899286001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderAccepted(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, ts_event=1715621791898057001)
2024-05-13T17:36:31.907771001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62762.80,62762.90,12.784,3.231,1715621791808999936)
2024-05-13T17:36:31.912503001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62762.90,0.003,BUYER,289b1033-2586-553d-affe-2e7a57e6d938,1715621791812000000)
2024-05-13T17:36:31.920744001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62762.80,62762.90,13.287,3.328,1715621791822000128)
2024-05-13T17:36:31.928510001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62762.80,62762.90,13.287,3.228,1715621791830000128)
2024-05-13T17:36:31.938247001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62762.80,62762.90,14.012,3.228,1715621791840000000)
2024-05-13T17:36:31.958593001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62764.00,62762.90,0.410,3.228,1715621791860000000)
2024-05-13T17:36:31.959248001Z [DEBUG] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [0.06276345, 0.2662967732638889, 0.0, -0.7746014293567894, 0.0, 4.667407381691325, 0.5366505086817919]
2024-05-13T17:36:31.961470001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send buy order
2024-05-13T17:36:31.961585001Z [DEBUG] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Drop buy order LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_738.89 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-113, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:31.961614001Z [WARN] PAPER-TRADING-001.Throttler-market_maker_buy_order_throttler: Dropped LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_738.89 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-113, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:31.961638001Z [DEBUG] PAPER-TRADING-001.nautilus_common::timer: Cancel timer 'market_maker_buy_order_throttler|DEQUE'
2024-05-13T17:36:31.961650001Z [DEBUG] PAPER-TRADING-001.Throttler-market_maker_buy_order_throttler: Set new time alert market_maker_buy_order_throttler|DEQUE at 1715621792517146000, now: 1715621791961556001
2024-05-13T17:36:31.961662001Z [DEBUG] PAPER-TRADING-001.nautilus_common::timer: Creating timer 'market_maker_buy_order_throttler|DEQUE'
2024-05-13T17:36:31.962066001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send sell order
2024-05-13T17:36:31.962119001Z [DEBUG] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Drop sell order LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_800.56 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-114, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:31.962137001Z [WARN] PAPER-TRADING-001.Throttler-market_maker_sell_order_throttler: Dropped LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_800.56 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-114, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:31.962155001Z [DEBUG] PAPER-TRADING-001.Throttler-market_maker_sell_order_throttler: Set new time alert market_maker_sell_order_throttler|DEQUE at 1715621792518006000, now: 1715621791961951001
2024-05-13T17:36:31.962167001Z [DEBUG] PAPER-TRADING-001.nautilus_common::timer: Creating timer 'market_maker_sell_order_throttler|DEQUE'
2024-05-13T17:36:31.968014001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62764.30,62764.30,9.334,3.228,1715621791870000128)
2024-05-13T17:36:31.987958001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62764.30,62764.40,11.431,0.225,1715621791880000000)
2024-05-13T17:36:31.989189001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62764.30,62764.40,10.235,0.225,1715621791889999872)
2024-05-13T17:36:31.998666001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62764.30,62764.40,11.018,0.225,1715621791900000000)
2024-05-13T17:36:32.002517001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing Bar(BTCUSDT-LINEAR.BYBIT-1-SECOND-MID-INTERNAL,62745.850,62764.350,62745.850,62764.350,267.655,1715621792000000000)
2024-05-13T17:36:32.008664001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62764.30,62764.40,11.018,0.025,1715621791910000128)
2024-05-13T17:36:32.012088001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62764.40,0.025,BUYER,f0cf29dd-8c3d-55bb-9905-f8226162c33a,1715621791912000000)
2024-05-13T17:36:32.019068001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62764.40,14.040,0.025,1715621791920000000)
2024-05-13T17:36:32.028267001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.241,1.428,1715621791928999936)
2024-05-13T17:36:32.038084001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.172,1.428,1715621791940000000)
2024-05-13T17:36:32.089334001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.799,1.428,1715621791990000128)
2024-05-13T17:36:32.098445001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.797,1.428,1715621792000000000)
2024-05-13T17:36:32.107890001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.795,1.428,1715621792008999936)
2024-05-13T17:36:32.138168001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.495,1.428,1715621792040000000)
2024-05-13T17:36:32.178350001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.495,1.183,1715621792080000000)
2024-05-13T17:36:32.235353001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62765.60,0.002,BUYER,6dacf15f-730c-56fc-976e-dda579986ef6,1715621792135000064)
2024-05-13T17:36:32.237889001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.495,1.181,1715621792140000000)
2024-05-13T17:36:32.248411001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.815,1.181,1715621792150000128)
2024-05-13T17:36:32.331685001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62765.50,62765.60,13.815,0.023,1715621792230000128)
2024-05-13T17:36:32.338142001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62765.60,2.570,0.023,1715621792240000000)
2024-05-13T17:36:32.342870001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62766.90,0.001,BUYER,9d4d6408-3ba7-5596-a460-4af85cb4fcfc,1715621792241999872)
2024-05-13T17:36:32.342994001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62766.90,0.001,BUYER,5783cd47-fa40-537e-9b7f-920ef5b099f3,1715621792241999872)
2024-05-13T17:36:32.346104001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62766.90,0.003,BUYER,3b260b0f-3a66-58b2-8a6b-62d2ed1d22e3,1715621792246000128)
2024-05-13T17:36:32.346376001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62766.90,0.003,BUYER,505d4e6a-ad08-5b68-905a-867b2e547e7c,1715621792247000064)
2024-05-13T17:36:32.347229001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.383,1.122,1715621792248999936)
2024-05-13T17:36:32.352908001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62766.90,0.003,BUYER,905af3bd-aa27-5766-856d-4c17ab10d4e5,1715621792252999936)
2024-05-13T17:36:32.358900001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.508,2.106,1715621792260000000)
2024-05-13T17:36:32.368070001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.510,2.106,1715621792270000128)
2024-05-13T17:36:32.378020001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.510,2.206,1715621792280000000)
2024-05-13T17:36:32.387936001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.515,2.206,1715621792289999872)
2024-05-13T17:36:32.408700001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.513,2.206,1715621792310000128)
2024-05-13T17:36:32.417989001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.511,2.206,1715621792320000000)
2024-05-13T17:36:32.438344001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.511,0.100,1715621792340000000)
2024-05-13T17:36:32.449588001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.989,0.245,1715621792350000128)
2024-05-13T17:36:32.458831001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62766.80,62766.90,9.689,0.100,1715621792360000000)
2024-05-13T17:36:32.478097001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62766.90,0.100,BUYER,a5997b81-3a1e-5604-95cb-bced08dfff82,1715621792377999872)
2024-05-13T17:36:32.478251001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62770.10,0.058,BUYER,09f3f507-f7b3-5327-956e-b225a3bb6d1f,1715621792377999872)
2024-05-13T17:36:32.478691001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62766.90,0.622,0.100,1715621792380000000)
2024-05-13T17:36:32.487657001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.687,5.948,1715621792390000128)
2024-05-13T17:36:32.498113001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.353,6.438,1715621792400000000)
2024-05-13T17:36:32.507751001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.853,6.568,1715621792408999936)
2024-05-13T17:36:32.518599001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.853,6.569,1715621792420000000)
2024-05-13T17:36:32.538785001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.733,6.569,1715621792440000000)
2024-05-13T17:36:32.548846001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.729,6.596,1715621792449999872)
2024-05-13T17:36:32.558023001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.727,6.596,1715621792460000000)
2024-05-13T17:36:32.658488001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.727,6.621,1715621792560000000)
2024-05-13T17:36:32.668654001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.283,6.621,1715621792569999872)
2024-05-13T17:36:32.748664001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.410,6.621,1715621792649999872)
2024-05-13T17:36:32.757848001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.283,6.621,1715621792660000000)
2024-05-13T17:36:32.768169001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.410,6.621,1715621792670000128)
2024-05-13T17:36:32.819020001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.283,6.621,1715621792720000000)
2024-05-13T17:36:32.828425001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.410,6.621,1715621792729999872)
2024-05-13T17:36:32.868591001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,5.410,6.266,1715621792769999872)
2024-05-13T17:36:32.877951001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,6.273,4.366,1715621792780000000)
2024-05-13T17:36:32.887862001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.452,3.022,1715621792790000128)
2024-05-13T17:36:32.898051001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.389,3.122,1715621792800000000)
2024-05-13T17:36:32.908316001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.389,3.022,1715621792809999872)
2024-05-13T17:36:32.919953001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.389,0.028,1715621792822000128)
2024-05-13T17:36:32.928081001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.389,0.467,1715621792830000128)
2024-05-13T17:36:32.947955001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.389,0.487,1715621792849999872)
2024-05-13T17:36:32.958102001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.698,0.487,1715621792860000000)
2024-05-13T17:36:32.988537001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.698,0.789,1715621792889999872)
2024-05-13T17:36:33.003090001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing Bar(BTCUSDT-LINEAR.BYBIT-1-SECOND-MID-INTERNAL,62764.350,62770.050,62764.350,62770.050,278.812,1715621793000000000)
2024-05-13T17:36:33.108921001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.698,0.047,1715621793009999872)
2024-05-13T17:36:33.109626001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62770.00,0.014,SELLER,404a8dfd-9010-5660-b1a0-99114d205860,1715621793008000000)
2024-05-13T17:36:33.117926001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.684,0.047,1715621793020000000)
2024-05-13T17:36:33.198300001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62770.00,62770.10,7.685,0.047,1715621793100000000)
2024-05-13T17:36:33.221596001Z [DEBUG] PAPER-TRADING-001.ExecEngine: Checking in-flight orders status...
2024-05-13T17:36:33.221727001Z [DEBUG] PAPER-TRADING-001.ExecEngine: Found 0 orders in-flight
2024-05-13T17:36:33.315139001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62770.10,0.027,BUYER,23f86348-9923-52c7-9189-c95d56caa7cd,1715621793214000128)
2024-05-13T17:36:33.315353001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62770.10,0.020,BUYER,05e70cbd-dfbc-5dfc-b36a-7520633a2e7b,1715621793214000128)
2024-05-13T17:36:33.315457001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62770.10,0.068,BUYER,bca3b76a-d88d-55bf-b70b-1809c9d29538,1715621793214000128)
2024-05-13T17:36:33.319241001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing QuoteTick(BTCUSDT-LINEAR.BYBIT,62772.00,62770.10,6.506,0.047,1715621793220999936)
2024-05-13T17:36:33.319809001Z [DEBUG] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [0.06277105, 0.26628102454861113, 4.84, 0.985655424996185, 0.196, 5.053538089519285, 0.6494956391669668]
2024-05-13T17:36:33.322534001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send buy order
2024-05-13T17:36:33.322675001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderPendingCancel(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-111, venue_order_id=BYBIT-617-097, account_id=BYBIT-001, ts_event=1715621793322535001)
2024-05-13T17:36:33.322750001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> CancelOrder(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-111, venue_order_id=BYBIT-617-097)
2024-05-13T17:36:33.322793001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-115, side=BUY, type=LIMIT, quantity=0.003, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '62721.78', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-13T17:36:33.323004001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_721.78 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-115, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:33.323031001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(BUY 0.003 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_721.78 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-115, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-13T17:36:33.323416001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: Send sell order
2024-05-13T17:36:33.323451001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderPendingCancel(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, ts_event=1715621793323112001)
2024-05-13T17:36:33.323481001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> CancelOrder(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098)
2024-05-13T17:36:33.323571001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-116, side=SELL, type=LIMIT, quantity=0.002, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '62820.32', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)
2024-05-13T17:36:33.324012001Z [DEBUG] PAPER-TRADING-001.Cache: Added LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_820.32 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-116, venue_order_id=None, position_id=None, tags=None)
2024-05-13T17:36:33.324080001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: [CMD]--> SubmitOrder(order=LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_820.32 GTC, status=INITIALIZED, client_order_id=O-20240513-1736-001-000-116, venue_order_id=None, position_id=None, tags=None), position_id=None)
2024-05-13T17:36:33.324182001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62772.10,0.002,BUYER,ba4f87c8-1624-5faf-9607-845fef51613a,1715621793222000128)
2024-05-13T17:36:33.324204001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62773.20,0.001,BUYER,6b75246e-ce8c-5158-b2e1-0f200666b8a6,1715621793222000128)
2024-05-13T17:36:33.324224001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=PENDING_CANCEL, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(62772.15), Quantity(0.001))]
2024-05-13T17:36:33.325127001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62776.10,0.003,BUYER,c9cb9db4-0240-5659-923a-70688a6b4c89,1715621793222000128)
2024-05-13T17:36:33.325180001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=PENDING_CANCEL, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(62772.15), Quantity(0.002))]
2024-05-13T17:36:33.325403001Z [DEBUG] PAPER-TRADING-001.Portfolio: Calculated PnLs: [Money(0.0557, USDT)]
2024-05-13T17:36:33.325550001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_maint=12.61230000 USDT
2024-05-13T17:36:33.325698001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_init=31.71700000 USDT
2024-05-13T17:36:33.325757001Z [INFO] PAPER-TRADING-001.Portfolio: Updated AccountState(account_id=BYBIT-001, account_type=MARGIN, base_currency=USDT, is_reported=False, balances=[AccountBalance(total=1_000_000.01800000 USDT, locked=44.32930000 USDT, free=999_955.68870000 USDT)], margins=[MarginBalance(initial=31.71700000 USDT, maintenance=12.61230000 USDT, instrument_id=BTCUSDT-LINEAR.BYBIT)], event_id=068da5e4-5578-46d8-b009-56d6ed25e591)
2024-05-13T17:36:33.325781001Z [DEBUG] PAPER-TRADING-001.Portfolio: Updated OrderFilled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, trade_id=BYBIT-617-093, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=SELL, order_type=LIMIT, last_qty=0.001, last_px=62_772.15 USDT, commission=0.0126 USDT, liquidity_side=MAKER, ts_event=1715621793321712001)
2024-05-13T17:36:33.325794001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderFilled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, trade_id=BYBIT-617-093, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=SELL, order_type=LIMIT, last_qty=0.001, last_px=62_772.15 USDT, commission=0.0126 USDT, liquidity_side=MAKER, ts_event=1715621793321712001)
2024-05-13T17:36:33.326788001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT net_position=0.001
2024-05-13T17:36:33.326807001Z [INFO] PAPER-TRADING-001.Portfolio: BTCUSDT-LINEAR.BYBIT margin_maint=6.30610000 USDT
2024-05-13T17:36:33.326823001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] PositionChanged(instrument_id=BTCUSDT-LINEAR.BYBIT, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, account_id=BYBIT-001, opening_order_id=O-20240513-1736-001-000-59, closing_order_id=None, entry=BUY, side=LONG, signed_qty=0.001, quantity=0.001, peak_qty=0.002, currency=USDT, avg_px_open=62716.45, avg_px_close=62772.15, realized_return=0.00089, realized_pnl=0.0180 USDT, unrealized_pnl=0.0557 USDT, ts_opened=1715621775000000000, ts_last=1715621793321712001, ts_closed=0, duration_ns=0)
2024-05-13T17:36:33.327172001Z [ERROR] PAPER-TRADING-001.ExecEngine: Error on applying OrderFilled(trader_id=PAPER-TRADING-001, strategy_id=ReinforcementLearningMarketMakerStrategy-000, instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, trade_id=BYBIT-617-094, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=SELL, order_type=LIMIT, last_qty=0.002, last_px=62_772.15 USDT, commission=0.0251 USDT, liquidity_side=MAKER, event_id=56f636a4-df6c-453a-afcd-51e9163ee6ac, ts_event=1715621793321736001, ts_init=1715621793321736001) to LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=FILLED, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, tags=None)
ValueError(invalid order.leaves_qty: was -0.001, order.quantity=0.002, order.filled_qty=0.001, fill.last_qty=0.002, fill=OrderFilled(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, account_id=BYBIT-001, trade_id=BYBIT-617-094, position_id=BTCUSDT-LINEAR.BYBIT-ReinforcementLearningMarketMakerStrategy-000, order_side=SELL, order_type=LIMIT, last_qty=0.002, last_px=62_772.15 USDT, commission=0.0251 USDT, liquidity_side=MAKER, ts_event=1715621793321736001))
Traceback (most recent call last):
  File "nautilus_trader/execution/engine.pyx", line 1007, in nautilus_trader.execution.engine.ExecutionEngine._apply_event_to_order
  File "nautilus_trader/model/orders/base.pyx", line 1010, in nautilus_trader.model.orders.base.Order.apply
  File "nautilus_trader/model/orders/base.pyx", line 1063, in nautilus_trader.model.orders.base.Order._filled


@davidsblom davidsblom reopened this May 13, 2024
@davidsblom
Copy link
Collaborator Author

Looking at the logs, I think the OrderMatchingEngine is applying to complete fills.

2024-05-13T17:36:33.324204001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62773.20,0.001,BUYER,6b75246e-ce8c-5158-b2e1-0f200666b8a6,1715621793222000128)
2024-05-13T17:36:33.324224001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=PENDING_CANCEL, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(62772.15), Quantity(0.001))]
2024-05-13T17:36:33.325127001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Processing TradeTick(BTCUSDT-LINEAR.BYBIT,62776.10,0.003,BUYER,c9cb9db4-0240-5659-923a-70688a6b4c89,1715621793222000128)
2024-05-13T17:36:33.325180001Z [DEBUG] PAPER-TRADING-001.OrderMatchingEngine(BYBIT): Applying fills to LimitOrder(SELL 0.002 BTCUSDT-LINEAR.BYBIT LIMIT @ 62_772.15 GTC, status=PENDING_CANCEL, client_order_id=O-20240513-1736-001-000-112, venue_order_id=BYBIT-617-098, position_id=None, tags=None), venue_position_id=None, position=None, fills=[(Price(62772.15), Quantity(0.002))]

The first one should be a complete fill, but the second one should be a partial fill as the size of the limit order is 0.002.

2024-05-13T17:36:31.890691001Z [INFO] PAPER-TRADING-001.ReinforcementLearningMarketMakerStrategy: <--[EVT] OrderInitialized(instrument_id=BTCUSDT-LINEAR.BYBIT, client_order_id=O-20240513-1736-001-000-112, side=SELL, type=LIMIT, quantity=0.002, time_in_force=GTC, post_only=True, reduce_only=False, quote_quantity=False, options={'price': '62772.15', 'display_qty': None, 'expire_time_ns': 0}, emulation_trigger=NO_TRIGGER, trigger_instrument_id=None, contingency_type=NO_CONTINGENCY, order_list_id=None, linked_order_ids=None, parent_order_id=None, exec_algorithm_id=None, exec_algorithm_params=None, exec_spawn_id=None, tags=None)

@davidsblom
Copy link
Collaborator Author

So thinking a bit more on this, what is perhaps happening is that 2 fill events are passed through the cache fills check resulting in an overfill. Maybe the second fill event needs to be modified with a smaller quantity.

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
bug Something isn't working
Projects
Development

Successfully merging a pull request may close this issue.

2 participants