diff --git a/src/MidasV1/logs/MidasV1.log b/src/MidasV1/logs/MidasV1.log index dc90254..39794ba 100644 --- a/src/MidasV1/logs/MidasV1.log +++ b/src/MidasV1/logs/MidasV1.log @@ -162,3 +162,118 @@ Traceback (most recent call last): ^^^^^^^ NameError: name 'MAGENTA' is not defined 2024-12-13 02:13:49,362 - MidasV1.Main - ERROR - Interrupt received. Shutting down gracefully... +2024-12-13 13:45:40,800 - MidasV1.Main - INFO - Starting MidasV1 Trading Bot... +2024-12-13 13:45:40,800 - MidasV1.InitialChecks - INFO - Checking Operating System... +2024-12-13 13:45:40,800 - MidasV1.InitialChecks - INFO - Operating System Linux is supported. +2024-12-13 13:45:40,800 - MidasV1.InitialChecks - INFO - Checking Dependencies... +2024-12-13 13:45:40,800 - MidasV1.InitialChecks - INFO - All dependencies are satisfied. +2024-12-13 13:45:40,800 - MidasV1.InitialChecks - INFO - Checking System Resources... +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - INFO - +CPU Cores: 12 +CPU Clock Speed: 2689.84 MHz +CPU Load Average (1m, 5m, 15m): (0.08935546875, 0.1201171875, 0.09375) +CPU Threads: 12 +Total RAM: 15.31 GB +Used RAM: 2.11 GB (21.4%) +Available RAM: 12.04 GB +Total Swap: 0.95 GB +Used Swap: 0.00 GB (0.0%) +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - INFO - Checking Connectivity with IB Gateway... +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - INFO - IB Gateway Connection Test +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - INFO - Attempting to connect to IB Gateway at 127.0.0.1:4002... +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - ERROR - [ERROR] id=-1, code=502, msg=Couldn't connect to TWS. Confirm that "Enable ActiveX and Socket EClients" +is enabled and connection port is the same as "Socket Port" on the +TWS "Edit->Global Configuration...->API->Settings" menu. Live Trading ports: +TWS: 7496; IB Gateway: 4001. Simulated Trading ports for new installations +of version 954.1 or newer: TWS: 7497; IB Gateway: 4002 +2024-12-13 13:45:40,801 - MidasV1.InitialChecks - ERROR - [ERROR] Connection to IB Gateway was closed unexpectedly! +2024-12-13 13:45:42,801 - MidasV1.Main - ERROR - Interrupt received. Shutting down gracefully... +2024-12-13 13:45:42,801 - MidasV1.Main - ERROR - Initial checks failed. Exiting program. +2024-12-13 13:45:50,765 - MidasV1.Main - INFO - Starting MidasV1 Trading Bot... +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - Checking Operating System... +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - Operating System Linux is supported. +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - Checking Dependencies... +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - All dependencies are satisfied. +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - Checking System Resources... +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - +CPU Cores: 12 +CPU Clock Speed: 2154.09 MHz +CPU Load Average (1m, 5m, 15m): (0.0751953125, 0.115234375, 0.091796875) +CPU Threads: 12 +Total RAM: 15.31 GB +Used RAM: 2.10 GB (21.4%) +Available RAM: 12.04 GB +Total Swap: 0.95 GB +Used Swap: 0.00 GB (0.0%) +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - Checking Connectivity with IB Gateway... +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:45:50,766 - MidasV1.InitialChecks - INFO - IB Gateway Connection Test +2024-12-13 13:45:50,767 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:45:50,767 - MidasV1.InitialChecks - INFO - Attempting to connect to IB Gateway at 127.0.0.1:4002... +2024-12-13 13:45:50,767 - MidasV1.InitialChecks - ERROR - [ERROR] id=-1, code=502, msg=Couldn't connect to TWS. Confirm that "Enable ActiveX and Socket EClients" +is enabled and connection port is the same as "Socket Port" on the +TWS "Edit->Global Configuration...->API->Settings" menu. Live Trading ports: +TWS: 7496; IB Gateway: 4001. Simulated Trading ports for new installations +of version 954.1 or newer: TWS: 7497; IB Gateway: 4002 +2024-12-13 13:45:50,767 - MidasV1.InitialChecks - ERROR - [ERROR] Connection to IB Gateway was closed unexpectedly! +2024-12-13 13:45:55,776 - MidasV1.InitialChecks - ERROR - [ERROR] Connection not established within timeout. +2024-12-13 13:45:55,777 - MidasV1.InitialChecks - WARNING - [WARN] No connection. Check Gateway settings and try again. +2024-12-13 13:45:55,777 - MidasV1.Main - ERROR - Initial checks failed. Exiting program. +2024-12-13 13:50:18,585 - MidasV1.Main - INFO - Starting MidasV1 Trading Bot... +2024-12-13 13:50:18,585 - MidasV1.InitialChecks - INFO - Checking Operating System... +2024-12-13 13:50:18,585 - MidasV1.InitialChecks - INFO - Operating System Linux is supported. +2024-12-13 13:50:18,585 - MidasV1.InitialChecks - INFO - Checking Dependencies... +2024-12-13 13:50:18,585 - MidasV1.InitialChecks - INFO - All dependencies are satisfied. +2024-12-13 13:50:18,585 - MidasV1.InitialChecks - INFO - Checking System Resources... +2024-12-13 13:50:18,586 - MidasV1.InitialChecks - INFO - +CPU Cores: 12 +CPU Clock Speed: 1581.67 MHz +CPU Load Average (1m, 5m, 15m): (0.76904296875, 0.32080078125, 0.16259765625) +CPU Threads: 12 +Total RAM: 15.31 GB +Used RAM: 2.74 GB (25.8%) +Available RAM: 11.37 GB +Total Swap: 0.95 GB +Used Swap: 0.00 GB (0.0%) +2024-12-13 13:50:18,586 - MidasV1.InitialChecks - INFO - Checking Connectivity with IB Gateway... +2024-12-13 13:50:18,586 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:50:18,586 - MidasV1.InitialChecks - INFO - IB Gateway Connection Test +2024-12-13 13:50:18,586 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:50:18,586 - MidasV1.InitialChecks - INFO - Attempting to connect to IB Gateway at 127.0.0.1:4002... +2024-12-13 13:50:18,642 - MidasV1.InitialChecks - INFO - [INFO] Managed accounts: DUE064818 +2024-12-13 13:50:18,684 - MidasV1.InitialChecks - INFO - [INFO] Next valid order ID: 1 +2024-12-13 13:50:18,684 - MidasV1.InitialChecks - INFO - [INFO/STATUS] id=-1, code=2104, msg=Market data farm connection is OK:usfarm +2024-12-13 13:50:18,684 - MidasV1.InitialChecks - INFO - [INFO/STATUS] id=-1, code=2106, msg=HMDS data farm connection is OK:ushmds +2024-12-13 13:50:18,684 - MidasV1.InitialChecks - INFO - [INFO/STATUS] id=-1, code=2158, msg=Sec-def data farm connection is OK:secdefnj +2024-12-13 13:50:18,728 - MidasV1.InitialChecks - INFO - [INFO] Connected successfully! +2024-12-13 13:50:18,728 - MidasV1.InitialChecks - INFO - Requesting account summary... +2024-12-13 13:50:18,771 - MidasV1.InitialChecks - INFO - [ACCOUNT SUMMARY] ReqId:1, Account:DUE064818, BuyingPower = 4014612.28 USD +2024-12-13 13:50:18,772 - MidasV1.InitialChecks - INFO - [ACCOUNT SUMMARY] ReqId:1, Account:DUE064818, EquityWithLoanValue = 1003653.07 USD +2024-12-13 13:50:18,772 - MidasV1.InitialChecks - INFO - [ACCOUNT SUMMARY] ReqId:1, Account:DUE064818, NetLiquidation = 1004890.64 USD +2024-12-13 13:50:18,772 - MidasV1.InitialChecks - INFO - [ACCOUNT SUMMARY] ReqId:1, Account:DUE064818, TotalCashValue = 1003653.07 USD +2024-12-13 13:50:18,772 - MidasV1.InitialChecks - INFO - [ACCOUNT SUMMARY END] ReqId: 1 +2024-12-13 13:50:23,729 - MidasV1.InitialChecks - INFO - [INFO] Successfully retrieved account summary data. +2024-12-13 13:50:23,729 - MidasV1.InitialChecks - INFO - IB Gateway is connected and ready for upcoming modules. +2024-12-13 13:50:23,729 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:50:23,729 - MidasV1.InitialChecks - INFO - Test Complete +2024-12-13 13:50:23,729 - MidasV1.InitialChecks - INFO - ──────────────────────────────────────────────────── +2024-12-13 13:50:23,729 - MidasV1.InitialChecks - INFO - All initial checks passed successfully. +2024-12-13 13:50:23,730 - MidasV1.StockListPetitioner - INFO - Starting Module 2: IBJTS List Petitioner... +2024-12-13 13:50:23,730 - MidasV1.StockListPetitioner - INFO - Loaded Scanner Criteria: + - Search Volume: 1000000 + - Net Change: 0.5 + - Percent Change: 2.0 +2024-12-13 13:50:23,730 - MidasV1.StockListPetitioner - INFO - Initiating scanner subscription with the above criteria... +2024-12-13 13:50:23,730 - MidasV1.StockListPetitioner - INFO - Scanner subscription requested successfully on attempt 1. +2024-12-13 13:50:23,730 - MidasV1.StockListPetitioner - INFO - Waiting for scanner data (timeout in 15 seconds)... +2024-12-13 13:50:24,556 - MidasV1.InitialChecks - ERROR - [ERROR] id=1001, code=162, msg=Historical Market Data Service error message:Scanner type with code ALL is disabled +2024-12-13 13:50:38,730 - MidasV1.StockListPetitioner - ERROR - Scanner subscription timed out. +2024-12-13 13:50:38,731 - MidasV1.StockListPetitioner - ERROR - Scanner subscription canceled due to timeout. +2024-12-13 13:50:38,731 - MidasV1.Main - INFO - Refined Stock List: [] +2024-12-13 13:50:38,731 - MidasV1.Main - INFO - Initial checks and Module 2 completed. Please review the logs and ensure everything is correct. +2024-12-13 13:50:38,732 - MidasV1.InitialChecks - ERROR - [ERROR] id=1001, code=365, msg=No scanner subscription found for ticker id:1001 +2024-12-13 13:50:41,816 - MidasV1.Main - INFO - User chose to exit the program. +2024-12-13 13:50:41,816 - MidasV1.InitialChecks - ERROR - [ERROR] Connection to IB Gateway was closed unexpectedly! +2024-12-13 13:50:41,816 - MidasV1.Main - INFO - Disconnected from IB Gateway. diff --git a/src/MidasV1/modules/__pycache__/initial_checks.cpython-311.pyc b/src/MidasV1/modules/__pycache__/initial_checks.cpython-311.pyc index 83934b8..6da8b9d 100644 Binary files a/src/MidasV1/modules/__pycache__/initial_checks.cpython-311.pyc and b/src/MidasV1/modules/__pycache__/initial_checks.cpython-311.pyc differ diff --git a/src/MidasV1/tests/test_stock_retriever.log b/src/MidasV1/tests/test_stock_retriever.log index 1acbfec..281d86f 100644 --- a/src/MidasV1/tests/test_stock_retriever.log +++ b/src/MidasV1/tests/test_stock_retriever.log @@ -1,435 +1,431 @@ -2024-12-13 02:01:32,318 - DEBUG - 139881771299920 connState: None -> 0 -2024-12-13 02:01:32,318 - DEBUG - 139881771299920 connState: None -> 0 -2024-12-13 02:01:32,319 - DEBUG - Connecting to 127.0.0.1:4002 w/ id:1 -2024-12-13 02:01:32,319 - DEBUG - 139881771299920 connState: 0 -> 1 -2024-12-13 02:01:32,319 - DEBUG - msg b'\x00\x00\x00\tv100..193' -2024-12-13 02:01:32,319 - DEBUG - REQUEST b'API\x00\x00\x00\x00\tv100..193' -2024-12-13 02:01:32,319 - DEBUG - acquiring lock -2024-12-13 02:01:32,319 - DEBUG - acquired lock -2024-12-13 02:01:32,319 - DEBUG - releasing lock -2024-12-13 02:01:32,319 - DEBUG - release lock -2024-12-13 02:01:32,319 - DEBUG - sendMsg: sent: 17 -2024-12-13 02:01:32,320 - DEBUG - no fields -2024-12-13 02:01:32,321 - DEBUG - len 30 raw:b'\x00\x00\x00\x1a187\x0020241213 02:01:31 EST\x00'| -2024-12-13 02:01:32,322 - DEBUG - ANSWER b'\x00\x00\x00\x1a187\x0020241213 02:01:31 EST\x00' -2024-12-13 02:01:32,322 - DEBUG - read_msg: size: 26 -2024-12-13 02:01:32,322 - DEBUG - size:26 msg:b'187\x0020241213 02:01:31 EST\x00' rest:b''| -2024-12-13 02:01:32,322 - DEBUG - fields (b'187', b'20241213 02:01:31 EST') -2024-12-13 02:01:32,322 - DEBUG - ANSWER Version:187 time:b'20241213 02:01:31 EST' -2024-12-13 02:01:32,322 - DEBUG - 139881771299920 connState: 1 -> 2 -2024-12-13 02:01:32,322 - DEBUG - EReader thread started -2024-12-13 02:01:32,322 - INFO - sent startApi -2024-12-13 02:01:32,322 - INFO - REQUEST startApi {} -2024-12-13 02:01:32,322 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,322 - INFO - SENDING startApi b'\x00\x00\x00\x0871\x002\x001\x00\x00' -2024-12-13 02:01:32,322 - DEBUG - acquiring lock -2024-12-13 02:01:32,322 - DEBUG - acquired lock -2024-12-13 02:01:32,322 - DEBUG - releasing lock -2024-12-13 02:01:32,322 - DEBUG - release lock -2024-12-13 02:01:32,322 - DEBUG - sendMsg: sent: 12 -2024-12-13 02:01:32,322 - INFO - ANSWER connectAck {} -2024-12-13 02:01:32,322 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,323 - DEBUG - len 19 raw:b'\x00\x00\x00\x0f15\x001\x00DUE064818\x00'| -2024-12-13 02:01:32,323 - DEBUG - reader loop, recvd size 19 -2024-12-13 02:01:32,323 - DEBUG - read_msg: size: 15 -2024-12-13 02:01:32,323 - DEBUG - size:15 msg.size:15 msg:|b''| buf:|| -2024-12-13 02:01:32,323 - DEBUG - fields (b'15', b'1', b'DUE064818') -2024-12-13 02:01:32,323 - DEBUG - In interpret(), handleInfo: wrap: meth:None prms:OrderedDict([('self', ), ('accountsList', )]) -2024-12-13 02:01:32,323 - DEBUG - field b'DUE064818' -2024-12-13 02:01:32,324 - DEBUG - arg DUE064818 type -2024-12-13 02:01:32,324 - DEBUG - calling > with <__main__.TestStockRetriever object at 0x7f38c349f450> ['DUE064818'] -2024-12-13 02:01:32,324 - INFO - ANSWER managedAccounts {'accountsList': 'DUE064818'} -2024-12-13 02:01:32,324 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,324 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,324 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,366 - DEBUG - len 227 raw:b'\x00\x00\x00\x069\x001\x001\x00\x00\x00\x0064\x002\x00-1\x002104\x00Market data farm connection is OK:usfarm\x00\x00\x00\x00\x00^4\x002\x00-1\x002107\x00HMDS data farm connection is inactive but should be available upon demand.ushmds\x00\x00\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| -2024-12-13 02:01:32,366 - DEBUG - reader loop, recvd size 227 -2024-12-13 02:01:32,366 - DEBUG - read_msg: size: 6 -2024-12-13 02:01:32,366 - DEBUG - size:6 msg.size:6 msg:|b'\x00\x00\x0064\x002\x00-1\x002104\x00Market data farm connection is OK:usfarm\x00\x00\x00\x00\x00^4\x002\x00-1\x002107\x00HMDS data farm connection is inactive but should be available upon demand.ushmds\x00\x00\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| buf:|| -2024-12-13 02:01:32,366 - DEBUG - read_msg: size: 54 -2024-12-13 02:01:32,366 - DEBUG - size:54 msg.size:54 msg:|b'\x00\x00\x00^4\x002\x00-1\x002107\x00HMDS data farm connection is inactive but should be available upon demand.ushmds\x00\x00\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| buf:|| -2024-12-13 02:01:32,366 - DEBUG - read_msg: size: 94 -2024-12-13 02:01:32,366 - DEBUG - size:94 msg.size:94 msg:|b'\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| buf:|| -2024-12-13 02:01:32,366 - DEBUG - read_msg: size: 57 -2024-12-13 02:01:32,367 - DEBUG - size:57 msg.size:57 msg:|b''| buf:|| -2024-12-13 02:01:32,367 - DEBUG - fields (b'9', b'1', b'1') -2024-12-13 02:01:32,367 - DEBUG - In interpret(), handleInfo: wrap: meth:None prms:OrderedDict([('self', ), ('orderId', )]) -2024-12-13 02:01:32,367 - DEBUG - field b'1' -2024-12-13 02:01:32,367 - DEBUG - arg 1 type -2024-12-13 02:01:32,367 - DEBUG - calling > with <__main__.TestStockRetriever object at 0x7f38c349f450> [1] -2024-12-13 02:01:32,367 - INFO - NextValidId received: 1 -2024-12-13 02:01:32,367 - INFO - Requesting market data for symbols... -2024-12-13 02:01:32,367 - INFO - REQUEST reqMktData {'reqId': 1001, 'contract': 139881771406224: 0,AAPL,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} -2024-12-13 02:01:32,367 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,367 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001001\x000\x00AAPL\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' -2024-12-13 02:01:32,367 - DEBUG - acquiring lock -2024-12-13 02:01:32,367 - DEBUG - acquired lock -2024-12-13 02:01:32,367 - DEBUG - releasing lock -2024-12-13 02:01:32,367 - DEBUG - release lock -2024-12-13 02:01:32,367 - DEBUG - sendMsg: sent: 53 -2024-12-13 02:01:32,367 - DEBUG - Requested market data for AAPL with ReqId: 1001 -2024-12-13 02:01:32,367 - INFO - REQUEST reqMktData {'reqId': 1002, 'contract': 139881771409296: 0,MSFT,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} -2024-12-13 02:01:32,367 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,367 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001002\x000\x00MSFT\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' -2024-12-13 02:01:32,367 - DEBUG - acquiring lock -2024-12-13 02:01:32,367 - DEBUG - acquired lock -2024-12-13 02:01:32,367 - DEBUG - releasing lock -2024-12-13 02:01:32,367 - DEBUG - release lock -2024-12-13 02:01:32,367 - DEBUG - sendMsg: sent: 53 -2024-12-13 02:01:32,368 - DEBUG - Requested market data for MSFT with ReqId: 1002 -2024-12-13 02:01:32,368 - INFO - REQUEST reqMktData {'reqId': 1003, 'contract': 139881771409424: 0,GOOGL,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} -2024-12-13 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,368 - INFO - SENDING reqMktData b'\x00\x00\x0021\x0011\x001003\x000\x00GOOGL\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' -2024-12-13 02:01:32,368 - DEBUG - acquiring lock -2024-12-13 02:01:32,368 - DEBUG - acquired lock -2024-12-13 02:01:32,368 - DEBUG - releasing lock -2024-12-13 02:01:32,368 - DEBUG - release lock -2024-12-13 02:01:32,368 - DEBUG - sendMsg: sent: 54 -2024-12-13 02:01:32,368 - DEBUG - Requested market data for GOOGL with ReqId: 1003 -2024-12-13 02:01:32,368 - INFO - REQUEST reqMktData {'reqId': 1004, 'contract': 139881771409360: 0,AMZN,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} -2024-12-13 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,368 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001004\x000\x00AMZN\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' -2024-12-13 02:01:32,368 - DEBUG - acquiring lock -2024-12-13 02:01:32,368 - DEBUG - acquired lock -2024-12-13 02:01:32,368 - DEBUG - releasing lock -2024-12-13 02:01:32,368 - DEBUG - release lock -2024-12-13 02:01:32,368 - DEBUG - sendMsg: sent: 53 -2024-12-13 02:01:32,368 - DEBUG - Requested market data for AMZN with ReqId: 1004 -2024-12-13 02:01:32,368 - INFO - REQUEST reqMktData {'reqId': 1005, 'contract': 139881771409552: 0,TSLA,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} -2024-12-13 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,368 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001005\x000\x00TSLA\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' -2024-12-13 02:01:32,368 - DEBUG - acquiring lock -2024-12-13 02:01:32,368 - DEBUG - acquired lock -2024-12-13 02:01:32,368 - DEBUG - releasing lock -2024-12-13 02:01:32,368 - DEBUG - release lock -2024-12-13 02:01:32,368 - DEBUG - sendMsg: sent: 53 -2024-12-13 02:01:32,368 - DEBUG - Requested market data for TSLA with ReqId: 1005 -2024-12-13 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,368 - DEBUG - conn:1 queue.sz:3 -2024-12-13 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,368 - DEBUG - fields (b'4', b'2', b'-1', b'2104', b'Market data farm connection is OK:usfarm', b'') -2024-12-13 02:01:32,368 - DEBUG - decode b'2' -2024-12-13 02:01:32,368 - DEBUG - decode b'-1' -2024-12-13 02:01:32,368 - DEBUG - decode b'2104' -2024-12-13 02:01:32,368 - DEBUG - decode b'Market data farm connection is OK:usfarm' -2024-12-13 02:01:32,369 - DEBUG - decode b'' -2024-12-13 02:01:32,369 - ERROR - Error. ReqId: -1, Code: 2104, Msg: Market data farm connection is OK:usfarm, Advanced Order Reject JSON: -2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,369 - DEBUG - conn:1 queue.sz:2 -2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,369 - DEBUG - fields (b'4', b'2', b'-1', b'2107', b'HMDS data farm connection is inactive but should be available upon demand.ushmds', b'') -2024-12-13 02:01:32,369 - DEBUG - decode b'2' -2024-12-13 02:01:32,369 - DEBUG - decode b'-1' -2024-12-13 02:01:32,369 - DEBUG - decode b'2107' -2024-12-13 02:01:32,369 - DEBUG - decode b'HMDS data farm connection is inactive but should be available upon demand.ushmds' -2024-12-13 02:01:32,369 - DEBUG - decode b'' -2024-12-13 02:01:32,369 - ERROR - Error. ReqId: -1, Code: 2107, Msg: HMDS data farm connection is inactive but should be available upon demand.ushmds, Advanced Order Reject JSON: -2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,369 - DEBUG - conn:1 queue.sz:1 -2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,369 - DEBUG - fields (b'4', b'2', b'-1', b'2158', b'Sec-def data farm connection is OK:secdefnj', b'') -2024-12-13 02:01:32,369 - DEBUG - decode b'2' -2024-12-13 02:01:32,369 - DEBUG - decode b'-1' -2024-12-13 02:01:32,369 - DEBUG - decode b'2158' -2024-12-13 02:01:32,369 - DEBUG - decode b'Sec-def data farm connection is OK:secdefnj' -2024-12-13 02:01:32,369 - DEBUG - decode b'' -2024-12-13 02:01:32,369 - ERROR - Error. ReqId: -1, Code: 2158, Msg: Sec-def data farm connection is OK:secdefnj, Advanced Order Reject JSON: -2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,369 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,433 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001001\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL\x00\x00"| -2024-12-13 02:01:32,433 - DEBUG - reader loop, recvd size 203 -2024-12-13 02:01:32,433 - DEBUG - read_msg: size: 199 -2024-12-13 02:01:32,433 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| -2024-12-13 02:01:32,434 - DEBUG - fields (b'4', b'2', b'1001', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL", b'') -2024-12-13 02:01:32,434 - DEBUG - decode b'2' -2024-12-13 02:01:32,434 - DEBUG - decode b'1001' -2024-12-13 02:01:32,434 - DEBUG - decode b'10089' -2024-12-13 02:01:32,434 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL" -2024-12-13 02:01:32,434 - DEBUG - decode b'' -2024-12-13 02:01:32,434 - ERROR - Error. ReqId: 1001, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: -2024-12-13 02:01:32,434 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,434 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,434 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,634 - DEBUG - queue.get: empty -2024-12-13 02:01:32,634 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,634 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,634 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,685 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001002\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL\x00\x00"| -2024-12-13 02:01:32,685 - DEBUG - reader loop, recvd size 203 -2024-12-13 02:01:32,685 - DEBUG - read_msg: size: 199 -2024-12-13 02:01:32,685 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| -2024-12-13 02:01:32,685 - DEBUG - fields (b'4', b'2', b'1002', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL", b'') -2024-12-13 02:01:32,685 - DEBUG - decode b'2' -2024-12-13 02:01:32,685 - DEBUG - decode b'1002' -2024-12-13 02:01:32,685 - DEBUG - decode b'10089' -2024-12-13 02:01:32,685 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL" -2024-12-13 02:01:32,685 - DEBUG - decode b'' -2024-12-13 02:01:32,685 - ERROR - Error. ReqId: 1002, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: -2024-12-13 02:01:32,685 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,685 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,685 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,710 - DEBUG - len 204 raw:b"\x00\x00\x00\xc84\x002\x001003\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL\x00\x00"| -2024-12-13 02:01:32,710 - DEBUG - reader loop, recvd size 204 -2024-12-13 02:01:32,710 - DEBUG - read_msg: size: 200 -2024-12-13 02:01:32,710 - DEBUG - size:200 msg.size:200 msg:|b''| buf:|| -2024-12-13 02:01:32,710 - DEBUG - fields (b'4', b'2', b'1003', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL", b'') -2024-12-13 02:01:32,710 - DEBUG - decode b'2' -2024-12-13 02:01:32,710 - DEBUG - decode b'1003' -2024-12-13 02:01:32,710 - DEBUG - decode b'10089' -2024-12-13 02:01:32,710 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL" -2024-12-13 02:01:32,710 - DEBUG - decode b'' -2024-12-13 02:01:32,710 - ERROR - Error. ReqId: 1003, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: -2024-12-13 02:01:32,710 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,710 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,710 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,711 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001004\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL\x00\x00"| -2024-12-13 02:01:32,711 - DEBUG - reader loop, recvd size 203 -2024-12-13 02:01:32,711 - DEBUG - read_msg: size: 199 -2024-12-13 02:01:32,711 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| -2024-12-13 02:01:32,711 - DEBUG - fields (b'4', b'2', b'1004', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL", b'') -2024-12-13 02:01:32,712 - DEBUG - decode b'2' -2024-12-13 02:01:32,712 - DEBUG - decode b'1004' -2024-12-13 02:01:32,712 - DEBUG - decode b'10089' -2024-12-13 02:01:32,712 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL" -2024-12-13 02:01:32,712 - DEBUG - decode b'' -2024-12-13 02:01:32,712 - ERROR - Error. ReqId: 1004, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: -2024-12-13 02:01:32,712 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,712 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,712 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,912 - DEBUG - queue.get: empty -2024-12-13 02:01:32,912 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,912 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,912 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,934 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001005\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL\x00\x00"| -2024-12-13 02:01:32,934 - DEBUG - reader loop, recvd size 203 -2024-12-13 02:01:32,934 - DEBUG - read_msg: size: 199 -2024-12-13 02:01:32,934 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| -2024-12-13 02:01:32,934 - DEBUG - fields (b'4', b'2', b'1005', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL", b'') -2024-12-13 02:01:32,934 - DEBUG - decode b'2' -2024-12-13 02:01:32,934 - DEBUG - decode b'1005' -2024-12-13 02:01:32,934 - DEBUG - decode b'10089' -2024-12-13 02:01:32,934 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL" -2024-12-13 02:01:32,934 - DEBUG - decode b'' -2024-12-13 02:01:32,934 - ERROR - Error. ReqId: 1005, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: -2024-12-13 02:01:32,935 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:32,935 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:32,935 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,135 - DEBUG - queue.get: empty -2024-12-13 02:01:33,135 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,135 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:33,135 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,335 - DEBUG - queue.get: empty -2024-12-13 02:01:33,335 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,335 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:33,335 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,536 - DEBUG - queue.get: empty -2024-12-13 02:01:33,536 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,536 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:33,536 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,736 - DEBUG - queue.get: empty -2024-12-13 02:01:33,736 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,736 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:33,736 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,935 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:33,935 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:33,936 - DEBUG - queue.get: empty -2024-12-13 02:01:33,936 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:33,936 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:33,936 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,137 - DEBUG - queue.get: empty -2024-12-13 02:01:34,137 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,137 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:34,137 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,337 - DEBUG - queue.get: empty -2024-12-13 02:01:34,337 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,337 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:34,337 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,537 - DEBUG - queue.get: empty -2024-12-13 02:01:34,538 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,538 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:34,538 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,738 - DEBUG - queue.get: empty -2024-12-13 02:01:34,738 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,738 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:34,738 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,937 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:34,937 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:34,938 - DEBUG - queue.get: empty -2024-12-13 02:01:34,938 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:34,938 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:34,938 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,139 - DEBUG - queue.get: empty -2024-12-13 02:01:35,139 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,139 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:35,139 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,339 - DEBUG - queue.get: empty -2024-12-13 02:01:35,339 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,339 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:35,339 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,539 - DEBUG - queue.get: empty -2024-12-13 02:01:35,539 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,539 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:35,539 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,740 - DEBUG - queue.get: empty -2024-12-13 02:01:35,740 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,740 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:35,740 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,938 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:35,938 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:35,940 - DEBUG - queue.get: empty -2024-12-13 02:01:35,940 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:35,940 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:35,940 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,141 - DEBUG - queue.get: empty -2024-12-13 02:01:36,141 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,141 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:36,141 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,341 - DEBUG - queue.get: empty -2024-12-13 02:01:36,341 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,341 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:36,341 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,541 - DEBUG - queue.get: empty -2024-12-13 02:01:36,541 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,541 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:36,541 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,742 - DEBUG - queue.get: empty -2024-12-13 02:01:36,742 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,742 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:36,742 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,939 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:36,939 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:36,942 - DEBUG - queue.get: empty -2024-12-13 02:01:36,942 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:36,942 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:36,942 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,143 - DEBUG - queue.get: empty -2024-12-13 02:01:37,143 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,143 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:37,143 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,343 - DEBUG - queue.get: empty -2024-12-13 02:01:37,343 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,343 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:37,343 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,543 - DEBUG - queue.get: empty -2024-12-13 02:01:37,543 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,543 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:37,543 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,744 - DEBUG - queue.get: empty -2024-12-13 02:01:37,744 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,744 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:37,744 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,941 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:37,941 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:37,944 - DEBUG - queue.get: empty -2024-12-13 02:01:37,944 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:37,944 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:37,944 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,144 - DEBUG - queue.get: empty -2024-12-13 02:01:38,144 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,144 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:38,145 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,345 - DEBUG - queue.get: empty -2024-12-13 02:01:38,345 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,345 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:38,345 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,545 - DEBUG - queue.get: empty -2024-12-13 02:01:38,545 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,545 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:38,545 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,746 - DEBUG - queue.get: empty -2024-12-13 02:01:38,746 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,746 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:38,746 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,942 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:38,942 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:38,946 - DEBUG - queue.get: empty -2024-12-13 02:01:38,946 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:38,946 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:38,946 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,146 - DEBUG - queue.get: empty -2024-12-13 02:01:39,146 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,146 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:39,146 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,346 - DEBUG - queue.get: empty -2024-12-13 02:01:39,347 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,347 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:39,347 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,547 - DEBUG - queue.get: empty -2024-12-13 02:01:39,547 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,547 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:39,547 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,747 - DEBUG - queue.get: empty -2024-12-13 02:01:39,747 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,747 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:39,747 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,942 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:39,942 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:39,948 - DEBUG - queue.get: empty -2024-12-13 02:01:39,948 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:39,948 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:39,948 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,148 - DEBUG - queue.get: empty -2024-12-13 02:01:40,148 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,148 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:40,148 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,348 - DEBUG - queue.get: empty -2024-12-13 02:01:40,348 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,348 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:40,348 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,549 - DEBUG - queue.get: empty -2024-12-13 02:01:40,549 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,549 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:40,549 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,749 - DEBUG - queue.get: empty -2024-12-13 02:01:40,749 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,749 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:40,749 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,943 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:40,943 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:40,949 - DEBUG - queue.get: empty -2024-12-13 02:01:40,949 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:40,949 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:40,949 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,150 - DEBUG - queue.get: empty -2024-12-13 02:01:41,150 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,150 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:41,150 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,350 - DEBUG - queue.get: empty -2024-12-13 02:01:41,350 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,350 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:41,350 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,550 - DEBUG - queue.get: empty -2024-12-13 02:01:41,550 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,550 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:41,550 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,751 - DEBUG - queue.get: empty -2024-12-13 02:01:41,751 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,751 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:41,751 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,945 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) -2024-12-13 02:01:41,945 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:41,951 - DEBUG - queue.get: empty -2024-12-13 02:01:41,951 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:41,951 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:41,951 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:42,152 - DEBUG - queue.get: empty -2024-12-13 02:01:42,152 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:42,152 - DEBUG - conn:1 queue.sz:0 -2024-12-13 02:01:42,152 - DEBUG - 139881771299920 isConn: 2, connConnected: True -2024-12-13 02:01:42,322 - WARNING - Timeout while waiting for market data. -2024-12-13 02:01:42,322 - DEBUG - 139881771299920 connState: 2 -> 0 -2024-12-13 02:01:42,322 - INFO - disconnecting -2024-12-13 02:01:42,322 - DEBUG - disconnecting -2024-12-13 02:01:42,322 - DEBUG - disconnected -2024-12-13 02:01:42,322 - INFO - Connection to IB Gateway closed. -2024-12-13 02:01:42,323 - DEBUG - 139881771299920 connState: None -> 0 -2024-12-13 02:01:42,352 - DEBUG - queue.get: empty -2024-12-13 02:01:42,352 - DEBUG - 139881771299920 isConn: 0, connConnected: None -2024-12-13 02:01:42,352 - DEBUG - conn:0 queue.sz:0 -2024-12-13 02:01:42,352 - DEBUG - 139881771299920 isConn: 0, connConnected: None -2024-12-13 02:01:42,352 - DEBUG - 139881771299920 connState: 0 -> 0 -2024-12-13 02:01:42,946 - DEBUG - socket broken, disconnecting -2024-12-13 02:01:42,946 - DEBUG - reader loop, recvd size 0 -2024-12-13 02:01:42,946 - DEBUG - EReader thread finished -2024-12-13 02:01:44,323 - INFO - TestStockRetriever completed. +2024-12-13 22:17:07,314 - DEBUG - 140417584002128 connState: None -> 0 +2024-12-13 22:17:07,314 - DEBUG - 140417584002128 connState: None -> 0 +2024-12-13 22:17:07,314 - DEBUG - Connecting to 127.0.0.1:4002 w/ id:1 +2024-12-13 22:17:07,314 - DEBUG - 140417584002128 connState: 0 -> 1 +2024-12-13 22:17:07,314 - DEBUG - msg b'\x00\x00\x00\tv100..193' +2024-12-13 22:17:07,314 - DEBUG - REQUEST b'API\x00\x00\x00\x00\tv100..193' +2024-12-13 22:17:07,314 - DEBUG - acquiring lock +2024-12-13 22:17:07,314 - DEBUG - acquired lock +2024-12-13 22:17:07,314 - DEBUG - releasing lock +2024-12-13 22:17:07,314 - DEBUG - release lock +2024-12-13 22:17:07,314 - DEBUG - sendMsg: sent: 17 +2024-12-13 22:17:07,315 - DEBUG - no fields +2024-12-13 22:17:07,351 - DEBUG - len 30 raw:b'\x00\x00\x00\x1a187\x0020241213 22:17:07 EST\x00'| +2024-12-13 22:17:07,351 - DEBUG - ANSWER b'\x00\x00\x00\x1a187\x0020241213 22:17:07 EST\x00' +2024-12-13 22:17:07,351 - DEBUG - read_msg: size: 26 +2024-12-13 22:17:07,351 - DEBUG - size:26 msg:b'187\x0020241213 22:17:07 EST\x00' rest:b''| +2024-12-13 22:17:07,351 - DEBUG - fields (b'187', b'20241213 22:17:07 EST') +2024-12-13 22:17:07,351 - DEBUG - ANSWER Version:187 time:b'20241213 22:17:07 EST' +2024-12-13 22:17:07,351 - DEBUG - 140417584002128 connState: 1 -> 2 +2024-12-13 22:17:07,352 - DEBUG - EReader thread started +2024-12-13 22:17:07,352 - INFO - sent startApi +2024-12-13 22:17:07,352 - INFO - REQUEST startApi {} +2024-12-13 22:17:07,352 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,352 - INFO - SENDING startApi b'\x00\x00\x00\x0871\x002\x001\x00\x00' +2024-12-13 22:17:07,352 - DEBUG - acquiring lock +2024-12-13 22:17:07,352 - DEBUG - acquired lock +2024-12-13 22:17:07,352 - DEBUG - releasing lock +2024-12-13 22:17:07,352 - DEBUG - release lock +2024-12-13 22:17:07,352 - DEBUG - sendMsg: sent: 12 +2024-12-13 22:17:07,352 - INFO - ANSWER connectAck {} +2024-12-13 22:17:07,352 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,369 - DEBUG - len 19 raw:b'\x00\x00\x00\x0f15\x001\x00DUE064818\x00'| +2024-12-13 22:17:07,369 - DEBUG - reader loop, recvd size 19 +2024-12-13 22:17:07,369 - DEBUG - read_msg: size: 15 +2024-12-13 22:17:07,369 - DEBUG - size:15 msg.size:15 msg:|b''| buf:|| +2024-12-13 22:17:07,370 - DEBUG - fields (b'15', b'1', b'DUE064818') +2024-12-13 22:17:07,370 - DEBUG - In interpret(), handleInfo: wrap: meth:None prms:OrderedDict([('self', ), ('accountsList', )]) +2024-12-13 22:17:07,370 - DEBUG - field b'DUE064818' +2024-12-13 22:17:07,370 - DEBUG - arg DUE064818 type +2024-12-13 22:17:07,370 - DEBUG - calling > with <__main__.TestStockRetriever object at 0x7fb58436f450> ['DUE064818'] +2024-12-13 22:17:07,370 - INFO - ANSWER managedAccounts {'accountsList': 'DUE064818'} +2024-12-13 22:17:07,370 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,370 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,370 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,410 - DEBUG - len 185 raw:b'\x00\x00\x00\x069\x001\x001\x00\x00\x00\x0064\x002\x00-1\x002104\x00Market data farm connection is OK:usfarm\x00\x00\x00\x00\x0044\x002\x00-1\x002106\x00HMDS data farm connection is OK:ushmds\x00\x00\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| +2024-12-13 22:17:07,410 - DEBUG - reader loop, recvd size 185 +2024-12-13 22:17:07,410 - DEBUG - read_msg: size: 6 +2024-12-13 22:17:07,410 - DEBUG - size:6 msg.size:6 msg:|b'\x00\x00\x0064\x002\x00-1\x002104\x00Market data farm connection is OK:usfarm\x00\x00\x00\x00\x0044\x002\x00-1\x002106\x00HMDS data farm connection is OK:ushmds\x00\x00\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| buf:|| +2024-12-13 22:17:07,410 - DEBUG - read_msg: size: 54 +2024-12-13 22:17:07,410 - DEBUG - size:54 msg.size:54 msg:|b'\x00\x00\x0044\x002\x00-1\x002106\x00HMDS data farm connection is OK:ushmds\x00\x00\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| buf:|| +2024-12-13 22:17:07,411 - DEBUG - fields (b'9', b'1', b'1') +2024-12-13 22:17:07,411 - DEBUG - read_msg: size: 52 +2024-12-13 22:17:07,411 - DEBUG - In interpret(), handleInfo: wrap: meth:None prms:OrderedDict([('self', ), ('orderId', )]) +2024-12-13 22:17:07,412 - DEBUG - size:52 msg.size:52 msg:|b'\x00\x00\x0094\x002\x00-1\x002158\x00Sec-def data farm connection is OK:secdefnj\x00\x00'| buf:|| +2024-12-13 22:17:07,412 - DEBUG - field b'1' +2024-12-13 22:17:07,412 - DEBUG - read_msg: size: 57 +2024-12-13 22:17:07,413 - DEBUG - arg 1 type +2024-12-13 22:17:07,413 - DEBUG - calling > with <__main__.TestStockRetriever object at 0x7fb58436f450> [1] +2024-12-13 22:17:07,413 - DEBUG - size:57 msg.size:57 msg:|b''| buf:|| +2024-12-13 22:17:07,413 - INFO - NextValidId received: 1 +2024-12-13 22:17:07,414 - INFO - Requesting market data for symbols... +2024-12-13 22:17:07,414 - INFO - REQUEST reqMktData {'reqId': 1001, 'contract': 140417587752272: 0,AAPL,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} +2024-12-13 22:17:07,414 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,414 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001001\x000\x00AAPL\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' +2024-12-13 22:17:07,414 - DEBUG - acquiring lock +2024-12-13 22:17:07,414 - DEBUG - acquired lock +2024-12-13 22:17:07,414 - DEBUG - releasing lock +2024-12-13 22:17:07,414 - DEBUG - release lock +2024-12-13 22:17:07,414 - DEBUG - sendMsg: sent: 53 +2024-12-13 22:17:07,414 - DEBUG - Requested market data for AAPL with ReqId: 1001 +2024-12-13 22:17:07,414 - INFO - REQUEST reqMktData {'reqId': 1002, 'contract': 140417584111056: 0,MSFT,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} +2024-12-13 22:17:07,414 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,414 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001002\x000\x00MSFT\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' +2024-12-13 22:17:07,414 - DEBUG - acquiring lock +2024-12-13 22:17:07,414 - DEBUG - acquired lock +2024-12-13 22:17:07,414 - DEBUG - releasing lock +2024-12-13 22:17:07,414 - DEBUG - release lock +2024-12-13 22:17:07,414 - DEBUG - sendMsg: sent: 53 +2024-12-13 22:17:07,415 - DEBUG - Requested market data for MSFT with ReqId: 1002 +2024-12-13 22:17:07,415 - INFO - REQUEST reqMktData {'reqId': 1003, 'contract': 140417584110928: 0,GOOGL,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} +2024-12-13 22:17:07,415 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,415 - INFO - SENDING reqMktData b'\x00\x00\x0021\x0011\x001003\x000\x00GOOGL\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' +2024-12-13 22:17:07,415 - DEBUG - acquiring lock +2024-12-13 22:17:07,415 - DEBUG - acquired lock +2024-12-13 22:17:07,415 - DEBUG - releasing lock +2024-12-13 22:17:07,415 - DEBUG - release lock +2024-12-13 22:17:07,415 - DEBUG - sendMsg: sent: 54 +2024-12-13 22:17:07,415 - DEBUG - Requested market data for GOOGL with ReqId: 1003 +2024-12-13 22:17:07,415 - INFO - REQUEST reqMktData {'reqId': 1004, 'contract': 140417584111184: 0,AMZN,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} +2024-12-13 22:17:07,415 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,415 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001004\x000\x00AMZN\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' +2024-12-13 22:17:07,415 - DEBUG - acquiring lock +2024-12-13 22:17:07,415 - DEBUG - acquired lock +2024-12-13 22:17:07,415 - DEBUG - releasing lock +2024-12-13 22:17:07,415 - DEBUG - release lock +2024-12-13 22:17:07,415 - DEBUG - sendMsg: sent: 53 +2024-12-13 22:17:07,415 - DEBUG - Requested market data for AMZN with ReqId: 1004 +2024-12-13 22:17:07,415 - INFO - REQUEST reqMktData {'reqId': 1005, 'contract': 140417584111440: 0,TSLA,STK,,,0,,,SMART,,USD,,,False,,,,combo:, 'genericTickList': '', 'snapshot': False, 'regulatorySnapshot': False, 'mktDataOptions': []} +2024-12-13 22:17:07,415 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,415 - INFO - SENDING reqMktData b'\x00\x00\x0011\x0011\x001005\x000\x00TSLA\x00STK\x00\x000.0\x00\x00\x00SMART\x00\x00USD\x00\x00\x000\x00\x000\x000\x00\x00' +2024-12-13 22:17:07,415 - DEBUG - acquiring lock +2024-12-13 22:17:07,415 - DEBUG - acquired lock +2024-12-13 22:17:07,415 - DEBUG - releasing lock +2024-12-13 22:17:07,415 - DEBUG - release lock +2024-12-13 22:17:07,415 - DEBUG - sendMsg: sent: 53 +2024-12-13 22:17:07,415 - DEBUG - Requested market data for TSLA with ReqId: 1005 +2024-12-13 22:17:07,415 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,415 - DEBUG - conn:1 queue.sz:3 +2024-12-13 22:17:07,415 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,416 - DEBUG - fields (b'4', b'2', b'-1', b'2104', b'Market data farm connection is OK:usfarm', b'') +2024-12-13 22:17:07,416 - DEBUG - decode b'2' +2024-12-13 22:17:07,416 - DEBUG - decode b'-1' +2024-12-13 22:17:07,416 - DEBUG - decode b'2104' +2024-12-13 22:17:07,416 - DEBUG - decode b'Market data farm connection is OK:usfarm' +2024-12-13 22:17:07,416 - DEBUG - decode b'' +2024-12-13 22:17:07,416 - ERROR - Error. ReqId: -1, Code: 2104, Msg: Market data farm connection is OK:usfarm, Advanced Order Reject JSON: +2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,416 - DEBUG - conn:1 queue.sz:2 +2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,416 - DEBUG - fields (b'4', b'2', b'-1', b'2106', b'HMDS data farm connection is OK:ushmds', b'') +2024-12-13 22:17:07,416 - DEBUG - decode b'2' +2024-12-13 22:17:07,416 - DEBUG - decode b'-1' +2024-12-13 22:17:07,416 - DEBUG - decode b'2106' +2024-12-13 22:17:07,416 - DEBUG - decode b'HMDS data farm connection is OK:ushmds' +2024-12-13 22:17:07,416 - DEBUG - decode b'' +2024-12-13 22:17:07,416 - ERROR - Error. ReqId: -1, Code: 2106, Msg: HMDS data farm connection is OK:ushmds, Advanced Order Reject JSON: +2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,416 - DEBUG - conn:1 queue.sz:1 +2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,416 - DEBUG - fields (b'4', b'2', b'-1', b'2158', b'Sec-def data farm connection is OK:secdefnj', b'') +2024-12-13 22:17:07,416 - DEBUG - decode b'2' +2024-12-13 22:17:07,416 - DEBUG - decode b'-1' +2024-12-13 22:17:07,416 - DEBUG - decode b'2158' +2024-12-13 22:17:07,416 - DEBUG - decode b'Sec-def data farm connection is OK:secdefnj' +2024-12-13 22:17:07,416 - DEBUG - decode b'' +2024-12-13 22:17:07,416 - ERROR - Error. ReqId: -1, Code: 2158, Msg: Sec-def data farm connection is OK:secdefnj, Advanced Order Reject JSON: +2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,416 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,617 - DEBUG - queue.get: empty +2024-12-13 22:17:07,617 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,617 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,617 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,809 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001001\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL\x00\x00"| +2024-12-13 22:17:07,809 - DEBUG - reader loop, recvd size 203 +2024-12-13 22:17:07,809 - DEBUG - read_msg: size: 199 +2024-12-13 22:17:07,809 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| +2024-12-13 22:17:07,809 - DEBUG - fields (b'4', b'2', b'1001', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL", b'') +2024-12-13 22:17:07,809 - DEBUG - decode b'2' +2024-12-13 22:17:07,809 - DEBUG - decode b'1001' +2024-12-13 22:17:07,809 - DEBUG - decode b'10089' +2024-12-13 22:17:07,810 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL" +2024-12-13 22:17:07,810 - DEBUG - decode b'' +2024-12-13 22:17:07,810 - ERROR - Error. ReqId: 1001, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AAPL NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: +2024-12-13 22:17:07,810 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,810 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,810 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,860 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001002\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL\x00\x00"| +2024-12-13 22:17:07,860 - DEBUG - reader loop, recvd size 203 +2024-12-13 22:17:07,860 - DEBUG - read_msg: size: 199 +2024-12-13 22:17:07,861 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| +2024-12-13 22:17:07,861 - DEBUG - fields (b'4', b'2', b'1002', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL", b'') +2024-12-13 22:17:07,861 - DEBUG - decode b'2' +2024-12-13 22:17:07,861 - DEBUG - decode b'1002' +2024-12-13 22:17:07,861 - DEBUG - decode b'10089' +2024-12-13 22:17:07,861 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL" +2024-12-13 22:17:07,861 - DEBUG - decode b'' +2024-12-13 22:17:07,861 - ERROR - Error. ReqId: 1002, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.MSFT NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: +2024-12-13 22:17:07,861 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,862 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,862 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,864 - DEBUG - len 204 raw:b"\x00\x00\x00\xc84\x002\x001003\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL\x00\x00"| +2024-12-13 22:17:07,864 - DEBUG - reader loop, recvd size 204 +2024-12-13 22:17:07,865 - DEBUG - read_msg: size: 200 +2024-12-13 22:17:07,865 - DEBUG - size:200 msg.size:200 msg:|b''| buf:|| +2024-12-13 22:17:07,865 - DEBUG - fields (b'4', b'2', b'1003', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL", b'') +2024-12-13 22:17:07,865 - DEBUG - decode b'2' +2024-12-13 22:17:07,865 - DEBUG - decode b'1003' +2024-12-13 22:17:07,865 - DEBUG - decode b'10089' +2024-12-13 22:17:07,865 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL" +2024-12-13 22:17:07,865 - DEBUG - decode b'' +2024-12-13 22:17:07,866 - ERROR - Error. ReqId: 1003, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.GOOGL NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: +2024-12-13 22:17:07,866 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,866 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,866 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,866 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001004\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL\x00\x00"| +2024-12-13 22:17:07,867 - DEBUG - reader loop, recvd size 203 +2024-12-13 22:17:07,867 - DEBUG - read_msg: size: 199 +2024-12-13 22:17:07,867 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| +2024-12-13 22:17:07,867 - DEBUG - fields (b'4', b'2', b'1004', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL", b'') +2024-12-13 22:17:07,867 - DEBUG - decode b'2' +2024-12-13 22:17:07,867 - DEBUG - decode b'1004' +2024-12-13 22:17:07,867 - DEBUG - decode b'10089' +2024-12-13 22:17:07,867 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL" +2024-12-13 22:17:07,867 - DEBUG - decode b'' +2024-12-13 22:17:07,868 - ERROR - Error. ReqId: 1004, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.AMZN NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: +2024-12-13 22:17:07,868 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:07,868 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:07,868 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,038 - DEBUG - len 203 raw:b"\x00\x00\x00\xc74\x002\x001005\x0010089\x00Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL\x00\x00"| +2024-12-13 22:17:08,038 - DEBUG - reader loop, recvd size 203 +2024-12-13 22:17:08,039 - DEBUG - read_msg: size: 199 +2024-12-13 22:17:08,039 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| +2024-12-13 22:17:08,039 - DEBUG - fields (b'4', b'2', b'1005', b'10089', b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL", b'') +2024-12-13 22:17:08,039 - DEBUG - decode b'2' +2024-12-13 22:17:08,039 - DEBUG - decode b'1005' +2024-12-13 22:17:08,039 - DEBUG - decode b'10089' +2024-12-13 22:17:08,039 - DEBUG - decode b"Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL" +2024-12-13 22:17:08,039 - DEBUG - decode b'' +2024-12-13 22:17:08,040 - ERROR - Error. ReqId: 1005, Code: 10089, Msg: Requested market data requires additional subscription for API. See link in 'Market Data Connections' dialog for more details.Delayed market data is available.TSLA NASDAQ.NMS/TOP/ALL, Advanced Order Reject JSON: +2024-12-13 22:17:08,040 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,040 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:08,040 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,240 - DEBUG - queue.get: empty +2024-12-13 22:17:08,241 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,241 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:08,241 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,442 - DEBUG - queue.get: empty +2024-12-13 22:17:08,442 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,442 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:08,443 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,643 - DEBUG - queue.get: empty +2024-12-13 22:17:08,644 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,644 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:08,644 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,845 - DEBUG - queue.get: empty +2024-12-13 22:17:08,845 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:08,846 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:08,846 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,040 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:09,040 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:09,046 - DEBUG - queue.get: empty +2024-12-13 22:17:09,046 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,046 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:09,046 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,246 - DEBUG - queue.get: empty +2024-12-13 22:17:09,247 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,247 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:09,247 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,447 - DEBUG - queue.get: empty +2024-12-13 22:17:09,448 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,448 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:09,448 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,648 - DEBUG - queue.get: empty +2024-12-13 22:17:09,648 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,648 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:09,648 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,849 - DEBUG - queue.get: empty +2024-12-13 22:17:09,849 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:09,849 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:09,850 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,041 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:10,042 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:10,050 - DEBUG - queue.get: empty +2024-12-13 22:17:10,051 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,051 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:10,051 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,252 - DEBUG - queue.get: empty +2024-12-13 22:17:10,252 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,252 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:10,253 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,453 - DEBUG - queue.get: empty +2024-12-13 22:17:10,454 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,454 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:10,454 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,654 - DEBUG - queue.get: empty +2024-12-13 22:17:10,655 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,655 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:10,655 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,856 - DEBUG - queue.get: empty +2024-12-13 22:17:10,856 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:10,856 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:10,856 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,044 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:11,044 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:11,057 - DEBUG - queue.get: empty +2024-12-13 22:17:11,057 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,057 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:11,058 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,258 - DEBUG - queue.get: empty +2024-12-13 22:17:11,259 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,259 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:11,259 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,460 - DEBUG - queue.get: empty +2024-12-13 22:17:11,460 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,460 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:11,460 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,661 - DEBUG - queue.get: empty +2024-12-13 22:17:11,661 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,661 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:11,662 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,862 - DEBUG - queue.get: empty +2024-12-13 22:17:11,863 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:11,863 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:11,863 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,045 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:12,046 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:12,064 - DEBUG - queue.get: empty +2024-12-13 22:17:12,064 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,064 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:12,065 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,265 - DEBUG - queue.get: empty +2024-12-13 22:17:12,266 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,266 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:12,266 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,467 - DEBUG - queue.get: empty +2024-12-13 22:17:12,467 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,467 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:12,467 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,668 - DEBUG - queue.get: empty +2024-12-13 22:17:12,668 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,668 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:12,668 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,869 - DEBUG - queue.get: empty +2024-12-13 22:17:12,869 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:12,870 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:12,870 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,047 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:13,048 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:13,070 - DEBUG - queue.get: empty +2024-12-13 22:17:13,070 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,071 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:13,071 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,271 - DEBUG - queue.get: empty +2024-12-13 22:17:13,271 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,272 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:13,272 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,472 - DEBUG - queue.get: empty +2024-12-13 22:17:13,473 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,473 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:13,473 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,674 - DEBUG - queue.get: empty +2024-12-13 22:17:13,674 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,674 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:13,674 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,875 - DEBUG - queue.get: empty +2024-12-13 22:17:13,875 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:13,875 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:13,876 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,049 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:14,050 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:14,076 - DEBUG - queue.get: empty +2024-12-13 22:17:14,077 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,077 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:14,077 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,278 - DEBUG - queue.get: empty +2024-12-13 22:17:14,278 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,278 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:14,279 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,479 - DEBUG - queue.get: empty +2024-12-13 22:17:14,480 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,480 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:14,480 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,680 - DEBUG - queue.get: empty +2024-12-13 22:17:14,681 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,681 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:14,681 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,882 - DEBUG - queue.get: empty +2024-12-13 22:17:14,882 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:14,882 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:14,883 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,050 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:15,051 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:15,083 - DEBUG - queue.get: empty +2024-12-13 22:17:15,083 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,083 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:15,084 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,284 - DEBUG - queue.get: empty +2024-12-13 22:17:15,285 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,285 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:15,285 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,485 - DEBUG - queue.get: empty +2024-12-13 22:17:15,486 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,486 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:15,486 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,686 - DEBUG - queue.get: empty +2024-12-13 22:17:15,687 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,687 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:15,687 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,888 - DEBUG - queue.get: empty +2024-12-13 22:17:15,888 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:15,888 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:15,888 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,052 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:16,052 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:16,089 - DEBUG - queue.get: empty +2024-12-13 22:17:16,089 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,089 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:16,089 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,290 - DEBUG - queue.get: empty +2024-12-13 22:17:16,290 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,290 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:16,291 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,491 - DEBUG - queue.get: empty +2024-12-13 22:17:16,491 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,492 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:16,492 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,692 - DEBUG - queue.get: empty +2024-12-13 22:17:16,693 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,693 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:16,693 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,893 - DEBUG - queue.get: empty +2024-12-13 22:17:16,894 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:16,894 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:16,894 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:17,054 - DEBUG - socket timeout from recvMsg (, TimeoutError('timed out'), ) +2024-12-13 22:17:17,054 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:17,095 - DEBUG - queue.get: empty +2024-12-13 22:17:17,095 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:17,095 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:17,096 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:17,296 - DEBUG - queue.get: empty +2024-12-13 22:17:17,297 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:17,297 - DEBUG - conn:1 queue.sz:0 +2024-12-13 22:17:17,297 - DEBUG - 140417584002128 isConn: 2, connConnected: True +2024-12-13 22:17:17,353 - WARNING - Timeout while waiting for market data. +2024-12-13 22:17:17,353 - DEBUG - 140417584002128 connState: 2 -> 0 +2024-12-13 22:17:17,353 - INFO - disconnecting +2024-12-13 22:17:17,353 - DEBUG - disconnecting +2024-12-13 22:17:17,353 - DEBUG - disconnected +2024-12-13 22:17:17,353 - INFO - Connection to IB Gateway closed. +2024-12-13 22:17:17,353 - DEBUG - 140417584002128 connState: None -> 0 +2024-12-13 22:17:17,498 - DEBUG - queue.get: empty +2024-12-13 22:17:17,498 - DEBUG - 140417584002128 isConn: 0, connConnected: None +2024-12-13 22:17:17,498 - DEBUG - conn:0 queue.sz:0 +2024-12-13 22:17:17,499 - DEBUG - 140417584002128 isConn: 0, connConnected: None +2024-12-13 22:17:17,499 - DEBUG - 140417584002128 connState: 0 -> 0 +2024-12-13 22:17:18,055 - DEBUG - socket broken, disconnecting +2024-12-13 22:17:18,055 - DEBUG - reader loop, recvd size 0 +2024-12-13 22:17:18,055 - DEBUG - EReader thread finished +2024-12-13 22:17:19,354 - INFO - TestStockRetriever completed.