adding shit

This commit is contained in:
klein panic
2024-12-13 22:35:46 -05:00
parent 9ed03f6d7f
commit 4b695f3d9e
3 changed files with 546 additions and 435 deletions

View File

@@ -162,3 +162,118 @@ Traceback (most recent call last):
^^^^^^^ ^^^^^^^
NameError: name 'MAGENTA' is not defined NameError: name 'MAGENTA' is not defined
2024-12-13 02:13:49,362 - MidasV1.Main - ERROR - Interrupt received. Shutting down gracefully... 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.

View File

@@ -1,435 +1,431 @@
2024-12-13 02:01:32,318 - DEBUG - 139881771299920 connState: None -> 0 2024-12-13 22:17:07,314 - DEBUG - 140417584002128 connState: None -> 0
2024-12-13 02:01:32,318 - DEBUG - 139881771299920 connState: None -> 0 2024-12-13 22:17:07,314 - DEBUG - 140417584002128 connState: None -> 0
2024-12-13 02:01:32,319 - DEBUG - Connecting to 127.0.0.1:4002 w/ id:1 2024-12-13 22:17:07,314 - 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 22:17:07,314 - DEBUG - 140417584002128 connState: 0 -> 1
2024-12-13 02:01:32,319 - DEBUG - msg b'\x00\x00\x00\tv100..193' 2024-12-13 22:17:07,314 - 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 22:17:07,314 - DEBUG - REQUEST b'API\x00\x00\x00\x00\tv100..193'
2024-12-13 02:01:32,319 - DEBUG - acquiring lock 2024-12-13 22:17:07,314 - DEBUG - acquiring lock
2024-12-13 02:01:32,319 - DEBUG - acquired lock 2024-12-13 22:17:07,314 - DEBUG - acquired lock
2024-12-13 02:01:32,319 - DEBUG - releasing lock 2024-12-13 22:17:07,314 - DEBUG - releasing lock
2024-12-13 02:01:32,319 - DEBUG - release lock 2024-12-13 22:17:07,314 - DEBUG - release lock
2024-12-13 02:01:32,319 - DEBUG - sendMsg: sent: 17 2024-12-13 22:17:07,314 - DEBUG - sendMsg: sent: 17
2024-12-13 02:01:32,320 - DEBUG - no fields 2024-12-13 22:17:07,315 - 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 22:17:07,351 - DEBUG - len 30 raw:b'\x00\x00\x00\x1a187\x0020241213 22:17:07 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 22:17:07,351 - DEBUG - ANSWER b'\x00\x00\x00\x1a187\x0020241213 22:17:07 EST\x00'
2024-12-13 02:01:32,322 - DEBUG - read_msg: size: 26 2024-12-13 22:17:07,351 - 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 22:17:07,351 - DEBUG - size:26 msg:b'187\x0020241213 22:17:07 EST\x00' rest:b''|
2024-12-13 02:01:32,322 - DEBUG - fields (b'187', b'20241213 02:01:31 EST') 2024-12-13 22:17:07,351 - DEBUG - fields (b'187', b'20241213 22:17:07 EST')
2024-12-13 02:01:32,322 - DEBUG - ANSWER Version:187 time:b'20241213 02:01:31 EST' 2024-12-13 22:17:07,351 - DEBUG - ANSWER Version:187 time:b'20241213 22:17:07 EST'
2024-12-13 02:01:32,322 - DEBUG - 139881771299920 connState: 1 -> 2 2024-12-13 22:17:07,351 - DEBUG - 140417584002128 connState: 1 -> 2
2024-12-13 02:01:32,322 - DEBUG - EReader thread started 2024-12-13 22:17:07,352 - DEBUG - EReader thread started
2024-12-13 02:01:32,322 - INFO - sent startApi 2024-12-13 22:17:07,352 - INFO - sent startApi
2024-12-13 02:01:32,322 - INFO - REQUEST startApi {} 2024-12-13 22:17:07,352 - INFO - REQUEST startApi {}
2024-12-13 02:01:32,322 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,352 - DEBUG - 140417584002128 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 22:17:07,352 - 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 22:17:07,352 - DEBUG - acquiring lock
2024-12-13 02:01:32,322 - DEBUG - acquired lock 2024-12-13 22:17:07,352 - DEBUG - acquired lock
2024-12-13 02:01:32,322 - DEBUG - releasing lock 2024-12-13 22:17:07,352 - DEBUG - releasing lock
2024-12-13 02:01:32,322 - DEBUG - release lock 2024-12-13 22:17:07,352 - DEBUG - release lock
2024-12-13 02:01:32,322 - DEBUG - sendMsg: sent: 12 2024-12-13 22:17:07,352 - DEBUG - sendMsg: sent: 12
2024-12-13 02:01:32,322 - INFO - ANSWER connectAck {} 2024-12-13 22:17:07,352 - INFO - ANSWER connectAck {}
2024-12-13 02:01:32,322 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,352 - DEBUG - 140417584002128 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 22:17:07,369 - 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 22:17:07,369 - DEBUG - reader loop, recvd size 19
2024-12-13 02:01:32,323 - DEBUG - read_msg: size: 15 2024-12-13 22:17:07,369 - DEBUG - read_msg: size: 15
2024-12-13 02:01:32,323 - DEBUG - size:15 msg.size:15 msg:|b''| buf:|| 2024-12-13 22:17:07,369 - 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 22:17:07,370 - DEBUG - fields (b'15', b'1', b'DUE064818')
2024-12-13 02:01:32,323 - DEBUG - In interpret(), handleInfo: wrap:<function EWrapper.managedAccounts at 0x7f38c36bd3a0> meth:None prms:OrderedDict([('self', <Parameter "self">), ('accountsList', <Parameter "accountsList: str">)]) 2024-12-13 22:17:07,370 - DEBUG - In interpret(), handleInfo: wrap:<function EWrapper.managedAccounts at 0x7fb5845893a0> meth:None prms:OrderedDict([('self', <Parameter "self">), ('accountsList', <Parameter "accountsList: str">)])
2024-12-13 02:01:32,323 - DEBUG - field b'DUE064818' 2024-12-13 22:17:07,370 - DEBUG - field b'DUE064818'
2024-12-13 02:01:32,324 - DEBUG - arg DUE064818 type <class 'str'> 2024-12-13 22:17:07,370 - DEBUG - arg DUE064818 type <class 'str'>
2024-12-13 02:01:32,324 - DEBUG - calling <bound method EWrapper.managedAccounts of <__main__.TestStockRetriever object at 0x7f38c349f450>> with <__main__.TestStockRetriever object at 0x7f38c349f450> ['DUE064818'] 2024-12-13 22:17:07,370 - DEBUG - calling <bound method EWrapper.managedAccounts of <__main__.TestStockRetriever object at 0x7fb58436f450>> with <__main__.TestStockRetriever object at 0x7fb58436f450> ['DUE064818']
2024-12-13 02:01:32,324 - INFO - ANSWER managedAccounts {'accountsList': 'DUE064818'} 2024-12-13 22:17:07,370 - INFO - ANSWER managedAccounts {'accountsList': 'DUE064818'}
2024-12-13 02:01:32,324 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,370 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,324 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,370 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,324 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,370 - DEBUG - 140417584002128 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 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 02:01:32,366 - DEBUG - reader loop, recvd size 227 2024-12-13 22:17:07,410 - DEBUG - reader loop, recvd size 185
2024-12-13 02:01:32,366 - DEBUG - read_msg: size: 6 2024-12-13 22:17:07,410 - 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 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 02:01:32,366 - DEBUG - read_msg: size: 54 2024-12-13 22:17:07,410 - 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 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 02:01:32,366 - DEBUG - read_msg: size: 94 2024-12-13 22:17:07,411 - DEBUG - fields (b'9', b'1', b'1')
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 22:17:07,411 - DEBUG - read_msg: size: 52
2024-12-13 02:01:32,366 - DEBUG - read_msg: size: 57 2024-12-13 22:17:07,411 - DEBUG - In interpret(), handleInfo: wrap:<function EWrapper.nextValidId at 0x7fb584588e00> meth:None prms:OrderedDict([('self', <Parameter "self">), ('orderId', <Parameter "orderId: int">)])
2024-12-13 02:01:32,367 - DEBUG - size:57 msg.size:57 msg:|b''| buf:|| 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 02:01:32,367 - DEBUG - fields (b'9', b'1', b'1') 2024-12-13 22:17:07,412 - DEBUG - field b'1'
2024-12-13 02:01:32,367 - DEBUG - In interpret(), handleInfo: wrap:<function EWrapper.nextValidId at 0x7f38c36bce00> meth:None prms:OrderedDict([('self', <Parameter "self">), ('orderId', <Parameter "orderId: int">)]) 2024-12-13 22:17:07,412 - DEBUG - read_msg: size: 57
2024-12-13 02:01:32,367 - DEBUG - field b'1' 2024-12-13 22:17:07,413 - DEBUG - arg 1 type <class 'int'>
2024-12-13 02:01:32,367 - DEBUG - arg 1 type <class 'int'> 2024-12-13 22:17:07,413 - DEBUG - calling <bound method TestStockRetriever.nextValidId of <__main__.TestStockRetriever object at 0x7fb58436f450>> with <__main__.TestStockRetriever object at 0x7fb58436f450> [1]
2024-12-13 02:01:32,367 - DEBUG - calling <bound method TestStockRetriever.nextValidId of <__main__.TestStockRetriever object at 0x7f38c349f450>> with <__main__.TestStockRetriever object at 0x7f38c349f450> [1] 2024-12-13 22:17:07,413 - DEBUG - size:57 msg.size:57 msg:|b''| buf:||
2024-12-13 02:01:32,367 - INFO - NextValidId received: 1 2024-12-13 22:17:07,413 - INFO - NextValidId received: 1
2024-12-13 02:01:32,367 - INFO - Requesting market data for symbols... 2024-12-13 22:17:07,414 - 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 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 02:01:32,367 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,414 - DEBUG - 140417584002128 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 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 02:01:32,367 - DEBUG - acquiring lock 2024-12-13 22:17:07,414 - DEBUG - acquiring lock
2024-12-13 02:01:32,367 - DEBUG - acquired lock 2024-12-13 22:17:07,414 - DEBUG - acquired lock
2024-12-13 02:01:32,367 - DEBUG - releasing lock 2024-12-13 22:17:07,414 - DEBUG - releasing lock
2024-12-13 02:01:32,367 - DEBUG - release lock 2024-12-13 22:17:07,414 - DEBUG - release lock
2024-12-13 02:01:32,367 - DEBUG - sendMsg: sent: 53 2024-12-13 22:17:07,414 - DEBUG - sendMsg: sent: 53
2024-12-13 02:01:32,367 - DEBUG - Requested market data for AAPL with ReqId: 1001 2024-12-13 22:17:07,414 - 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 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 02:01:32,367 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,414 - DEBUG - 140417584002128 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 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 02:01:32,367 - DEBUG - acquiring lock 2024-12-13 22:17:07,414 - DEBUG - acquiring lock
2024-12-13 02:01:32,367 - DEBUG - acquired lock 2024-12-13 22:17:07,414 - DEBUG - acquired lock
2024-12-13 02:01:32,367 - DEBUG - releasing lock 2024-12-13 22:17:07,414 - DEBUG - releasing lock
2024-12-13 02:01:32,367 - DEBUG - release lock 2024-12-13 22:17:07,414 - DEBUG - release lock
2024-12-13 02:01:32,367 - DEBUG - sendMsg: sent: 53 2024-12-13 22:17:07,414 - DEBUG - sendMsg: sent: 53
2024-12-13 02:01:32,368 - DEBUG - Requested market data for MSFT with ReqId: 1002 2024-12-13 22:17:07,415 - 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 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 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,415 - DEBUG - 140417584002128 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 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 02:01:32,368 - DEBUG - acquiring lock 2024-12-13 22:17:07,415 - DEBUG - acquiring lock
2024-12-13 02:01:32,368 - DEBUG - acquired lock 2024-12-13 22:17:07,415 - DEBUG - acquired lock
2024-12-13 02:01:32,368 - DEBUG - releasing lock 2024-12-13 22:17:07,415 - DEBUG - releasing lock
2024-12-13 02:01:32,368 - DEBUG - release lock 2024-12-13 22:17:07,415 - DEBUG - release lock
2024-12-13 02:01:32,368 - DEBUG - sendMsg: sent: 54 2024-12-13 22:17:07,415 - DEBUG - sendMsg: sent: 54
2024-12-13 02:01:32,368 - DEBUG - Requested market data for GOOGL with ReqId: 1003 2024-12-13 22:17:07,415 - 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 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 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,415 - DEBUG - 140417584002128 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 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 02:01:32,368 - DEBUG - acquiring lock 2024-12-13 22:17:07,415 - DEBUG - acquiring lock
2024-12-13 02:01:32,368 - DEBUG - acquired lock 2024-12-13 22:17:07,415 - DEBUG - acquired lock
2024-12-13 02:01:32,368 - DEBUG - releasing lock 2024-12-13 22:17:07,415 - DEBUG - releasing lock
2024-12-13 02:01:32,368 - DEBUG - release lock 2024-12-13 22:17:07,415 - DEBUG - release lock
2024-12-13 02:01:32,368 - DEBUG - sendMsg: sent: 53 2024-12-13 22:17:07,415 - DEBUG - sendMsg: sent: 53
2024-12-13 02:01:32,368 - DEBUG - Requested market data for AMZN with ReqId: 1004 2024-12-13 22:17:07,415 - 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 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 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,415 - DEBUG - 140417584002128 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 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 02:01:32,368 - DEBUG - acquiring lock 2024-12-13 22:17:07,415 - DEBUG - acquiring lock
2024-12-13 02:01:32,368 - DEBUG - acquired lock 2024-12-13 22:17:07,415 - DEBUG - acquired lock
2024-12-13 02:01:32,368 - DEBUG - releasing lock 2024-12-13 22:17:07,415 - DEBUG - releasing lock
2024-12-13 02:01:32,368 - DEBUG - release lock 2024-12-13 22:17:07,415 - DEBUG - release lock
2024-12-13 02:01:32,368 - DEBUG - sendMsg: sent: 53 2024-12-13 22:17:07,415 - DEBUG - sendMsg: sent: 53
2024-12-13 02:01:32,368 - DEBUG - Requested market data for TSLA with ReqId: 1005 2024-12-13 22:17:07,415 - 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 22:17:07,415 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,368 - DEBUG - conn:1 queue.sz:3 2024-12-13 22:17:07,415 - DEBUG - conn:1 queue.sz:3
2024-12-13 02:01:32,368 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,415 - DEBUG - 140417584002128 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 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 02:01:32,368 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,368 - DEBUG - decode <class 'int'> b'-1' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'-1'
2024-12-13 02:01:32,368 - DEBUG - decode <class 'int'> b'2104' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'2104'
2024-12-13 02:01:32,368 - DEBUG - decode <class 'str'> b'Market data farm connection is OK:usfarm' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'str'> b'Market data farm connection is OK:usfarm'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'str'> b'' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'str'> 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 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 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,369 - DEBUG - conn:1 queue.sz:2 2024-12-13 22:17:07,416 - DEBUG - conn:1 queue.sz:2
2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,416 - DEBUG - 140417584002128 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 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 02:01:32,369 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'int'> b'-1' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'-1'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'int'> b'2107' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'2106'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'str'> b'HMDS data farm connection is inactive but should be available upon demand.ushmds' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'str'> b'HMDS data farm connection is OK:ushmds'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'str'> b'' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'str'> 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 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 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,369 - DEBUG - conn:1 queue.sz:1 2024-12-13 22:17:07,416 - DEBUG - conn:1 queue.sz:1
2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,416 - DEBUG - 140417584002128 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 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 02:01:32,369 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'int'> b'-1' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'-1'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'int'> b'2158' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'int'> b'2158'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'str'> b'Sec-def data farm connection is OK:secdefnj' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'str'> b'Sec-def data farm connection is OK:secdefnj'
2024-12-13 02:01:32,369 - DEBUG - decode <class 'str'> b'' 2024-12-13 22:17:07,416 - DEBUG - decode <class 'str'> 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 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 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,416 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,369 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,416 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,369 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,416 - DEBUG - 140417584002128 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 22:17:07,617 - DEBUG - queue.get: empty
2024-12-13 02:01:32,433 - DEBUG - reader loop, recvd size 203 2024-12-13 22:17:07,617 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,433 - DEBUG - read_msg: size: 199 2024-12-13 22:17:07,617 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,433 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| 2024-12-13 22:17:07,617 - DEBUG - 140417584002128 isConn: 2, connConnected: True
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 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 02:01:32,434 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,809 - DEBUG - reader loop, recvd size 203
2024-12-13 02:01:32,434 - DEBUG - decode <class 'int'> b'1001' 2024-12-13 22:17:07,809 - DEBUG - read_msg: size: 199
2024-12-13 02:01:32,434 - DEBUG - decode <class 'int'> b'10089' 2024-12-13 22:17:07,809 - DEBUG - size:199 msg.size:199 msg:|b''| buf:||
2024-12-13 02:01:32,434 - DEBUG - decode <class 'str'> 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,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 02:01:32,434 - DEBUG - decode <class 'str'> b'' 2024-12-13 22:17:07,809 - DEBUG - decode <class 'int'> b'2'
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 22:17:07,809 - DEBUG - decode <class 'int'> b'1001'
2024-12-13 02:01:32,434 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,809 - DEBUG - decode <class 'int'> b'10089'
2024-12-13 02:01:32,434 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,810 - DEBUG - decode <class 'str'> 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 - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,810 - DEBUG - decode <class 'str'> b''
2024-12-13 02:01:32,634 - DEBUG - queue.get: empty 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 02:01:32,634 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,810 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,634 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,810 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,634 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,810 - DEBUG - 140417584002128 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 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 02:01:32,685 - DEBUG - reader loop, recvd size 203 2024-12-13 22:17:07,860 - DEBUG - reader loop, recvd size 203
2024-12-13 02:01:32,685 - DEBUG - read_msg: size: 199 2024-12-13 22:17:07,860 - DEBUG - read_msg: size: 199
2024-12-13 02:01:32,685 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| 2024-12-13 22:17:07,861 - 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 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 02:01:32,685 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,861 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,685 - DEBUG - decode <class 'int'> b'1002' 2024-12-13 22:17:07,861 - DEBUG - decode <class 'int'> b'1002'
2024-12-13 02:01:32,685 - DEBUG - decode <class 'int'> b'10089' 2024-12-13 22:17:07,861 - DEBUG - decode <class 'int'> b'10089'
2024-12-13 02:01:32,685 - DEBUG - decode <class 'str'> 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 <class 'str'> 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 <class 'str'> b'' 2024-12-13 22:17:07,861 - DEBUG - decode <class 'str'> 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 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 02:01:32,685 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,861 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,685 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,862 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,685 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,862 - DEBUG - 140417584002128 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 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 02:01:32,710 - DEBUG - reader loop, recvd size 204 2024-12-13 22:17:07,864 - DEBUG - reader loop, recvd size 204
2024-12-13 02:01:32,710 - DEBUG - read_msg: size: 200 2024-12-13 22:17:07,865 - DEBUG - read_msg: size: 200
2024-12-13 02:01:32,710 - DEBUG - size:200 msg.size:200 msg:|b''| buf:|| 2024-12-13 22:17:07,865 - 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 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 02:01:32,710 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,865 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,710 - DEBUG - decode <class 'int'> b'1003' 2024-12-13 22:17:07,865 - DEBUG - decode <class 'int'> b'1003'
2024-12-13 02:01:32,710 - DEBUG - decode <class 'int'> b'10089' 2024-12-13 22:17:07,865 - DEBUG - decode <class 'int'> b'10089'
2024-12-13 02:01:32,710 - DEBUG - decode <class 'str'> 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 <class 'str'> 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 <class 'str'> b'' 2024-12-13 22:17:07,865 - DEBUG - decode <class 'str'> 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 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 02:01:32,710 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,866 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,710 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,866 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,710 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,866 - DEBUG - 140417584002128 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 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 02:01:32,711 - DEBUG - reader loop, recvd size 203 2024-12-13 22:17:07,867 - DEBUG - reader loop, recvd size 203
2024-12-13 02:01:32,711 - DEBUG - read_msg: size: 199 2024-12-13 22:17:07,867 - DEBUG - read_msg: size: 199
2024-12-13 02:01:32,711 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| 2024-12-13 22:17:07,867 - 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 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 02:01:32,712 - DEBUG - decode <class 'int'> b'2' 2024-12-13 22:17:07,867 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,712 - DEBUG - decode <class 'int'> b'1004' 2024-12-13 22:17:07,867 - DEBUG - decode <class 'int'> b'1004'
2024-12-13 02:01:32,712 - DEBUG - decode <class 'int'> b'10089' 2024-12-13 22:17:07,867 - DEBUG - decode <class 'int'> b'10089'
2024-12-13 02:01:32,712 - DEBUG - decode <class 'str'> 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 <class 'str'> 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 <class 'str'> b'' 2024-12-13 22:17:07,867 - DEBUG - decode <class 'str'> 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 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 02:01:32,712 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,868 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,712 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:07,868 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,712 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:07,868 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,912 - DEBUG - queue.get: empty 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 02:01:32,912 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,038 - DEBUG - reader loop, recvd size 203
2024-12-13 02:01:32,912 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:08,039 - DEBUG - read_msg: size: 199
2024-12-13 02:01:32,912 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,039 - DEBUG - size:199 msg.size:199 msg:|b''| buf:||
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 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 02:01:32,934 - DEBUG - reader loop, recvd size 203 2024-12-13 22:17:08,039 - DEBUG - decode <class 'int'> b'2'
2024-12-13 02:01:32,934 - DEBUG - read_msg: size: 199 2024-12-13 22:17:08,039 - DEBUG - decode <class 'int'> b'1005'
2024-12-13 02:01:32,934 - DEBUG - size:199 msg.size:199 msg:|b''| buf:|| 2024-12-13 22:17:08,039 - DEBUG - decode <class 'int'> b'10089'
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 22:17:08,039 - DEBUG - decode <class 'str'> 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 <class 'int'> b'2' 2024-12-13 22:17:08,039 - DEBUG - decode <class 'str'> b''
2024-12-13 02:01:32,934 - DEBUG - decode <class 'int'> b'1005' 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 02:01:32,934 - DEBUG - decode <class 'int'> b'10089' 2024-12-13 22:17:08,040 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,934 - DEBUG - decode <class 'str'> 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,040 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,934 - DEBUG - decode <class 'str'> b'' 2024-12-13 22:17:08,040 - DEBUG - 140417584002128 isConn: 2, connConnected: True
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 22:17:08,240 - DEBUG - queue.get: empty
2024-12-13 02:01:32,935 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,241 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:32,935 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:08,241 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:32,935 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,241 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,135 - DEBUG - queue.get: empty 2024-12-13 22:17:08,442 - DEBUG - queue.get: empty
2024-12-13 02:01:33,135 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,442 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,135 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:08,442 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:33,135 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,443 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,335 - DEBUG - queue.get: empty 2024-12-13 22:17:08,643 - DEBUG - queue.get: empty
2024-12-13 02:01:33,335 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,644 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,335 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:08,644 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:33,335 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,644 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,536 - DEBUG - queue.get: empty 2024-12-13 22:17:08,845 - DEBUG - queue.get: empty
2024-12-13 02:01:33,536 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,845 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,536 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:08,846 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:33,536 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:08,846 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,736 - DEBUG - queue.get: empty 2024-12-13 22:17:09,040 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb58438a100>)
2024-12-13 02:01:33,736 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,040 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:33,736 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:09,046 - DEBUG - queue.get: empty
2024-12-13 02:01:33,736 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,046 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,935 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34ba040>) 2024-12-13 22:17:09,046 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:33,935 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:09,046 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,936 - DEBUG - queue.get: empty 2024-12-13 22:17:09,246 - DEBUG - queue.get: empty
2024-12-13 02:01:33,936 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,247 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:33,936 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:09,247 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:33,936 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,247 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,137 - DEBUG - queue.get: empty 2024-12-13 22:17:09,447 - DEBUG - queue.get: empty
2024-12-13 02:01:34,137 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,448 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,137 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:09,448 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:34,137 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,448 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,337 - DEBUG - queue.get: empty 2024-12-13 22:17:09,648 - DEBUG - queue.get: empty
2024-12-13 02:01:34,337 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,648 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,337 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:09,648 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:34,337 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,648 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,537 - DEBUG - queue.get: empty 2024-12-13 22:17:09,849 - DEBUG - queue.get: empty
2024-12-13 02:01:34,538 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,849 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,538 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:09,849 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:34,538 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:09,850 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,738 - DEBUG - queue.get: empty 2024-12-13 22:17:10,041 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb584389d80>)
2024-12-13 02:01:34,738 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,042 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:34,738 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:10,050 - DEBUG - queue.get: empty
2024-12-13 02:01:34,738 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,051 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,937 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34b9ec0>) 2024-12-13 22:17:10,051 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:34,937 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:10,051 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,938 - DEBUG - queue.get: empty 2024-12-13 22:17:10,252 - DEBUG - queue.get: empty
2024-12-13 02:01:34,938 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,252 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:34,938 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:10,252 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:34,938 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,253 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,139 - DEBUG - queue.get: empty 2024-12-13 22:17:10,453 - DEBUG - queue.get: empty
2024-12-13 02:01:35,139 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,454 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,139 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:10,454 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:35,139 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,454 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,339 - DEBUG - queue.get: empty 2024-12-13 22:17:10,654 - DEBUG - queue.get: empty
2024-12-13 02:01:35,339 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,655 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,339 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:10,655 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:35,339 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,655 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,539 - DEBUG - queue.get: empty 2024-12-13 22:17:10,856 - DEBUG - queue.get: empty
2024-12-13 02:01:35,539 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,856 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,539 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:10,856 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:35,539 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:10,856 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,740 - DEBUG - queue.get: empty 2024-12-13 22:17:11,044 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb58438a080>)
2024-12-13 02:01:35,740 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,044 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:35,740 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:11,057 - DEBUG - queue.get: empty
2024-12-13 02:01:35,740 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,057 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,938 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34ba1c0>) 2024-12-13 22:17:11,057 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:35,938 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:11,058 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,940 - DEBUG - queue.get: empty 2024-12-13 22:17:11,258 - DEBUG - queue.get: empty
2024-12-13 02:01:35,940 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,259 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:35,940 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:11,259 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:35,940 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,259 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,141 - DEBUG - queue.get: empty 2024-12-13 22:17:11,460 - DEBUG - queue.get: empty
2024-12-13 02:01:36,141 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,460 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,141 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:11,460 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:36,141 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,460 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,341 - DEBUG - queue.get: empty 2024-12-13 22:17:11,661 - DEBUG - queue.get: empty
2024-12-13 02:01:36,341 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,661 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,341 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:11,661 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:36,341 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,662 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,541 - DEBUG - queue.get: empty 2024-12-13 22:17:11,862 - DEBUG - queue.get: empty
2024-12-13 02:01:36,541 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,863 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,541 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:11,863 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:36,541 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:11,863 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,742 - DEBUG - queue.get: empty 2024-12-13 22:17:12,045 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb58438a100>)
2024-12-13 02:01:36,742 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,046 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:36,742 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:12,064 - DEBUG - queue.get: empty
2024-12-13 02:01:36,742 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,064 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,939 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34ba040>) 2024-12-13 22:17:12,064 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:36,939 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:12,065 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,942 - DEBUG - queue.get: empty 2024-12-13 22:17:12,265 - DEBUG - queue.get: empty
2024-12-13 02:01:36,942 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,266 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:36,942 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:12,266 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:36,942 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,266 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,143 - DEBUG - queue.get: empty 2024-12-13 22:17:12,467 - DEBUG - queue.get: empty
2024-12-13 02:01:37,143 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,467 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,143 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:12,467 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:37,143 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,467 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,343 - DEBUG - queue.get: empty 2024-12-13 22:17:12,668 - DEBUG - queue.get: empty
2024-12-13 02:01:37,343 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,668 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,343 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:12,668 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:37,343 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,668 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,543 - DEBUG - queue.get: empty 2024-12-13 22:17:12,869 - DEBUG - queue.get: empty
2024-12-13 02:01:37,543 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,869 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,543 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:12,870 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:37,543 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:12,870 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,744 - DEBUG - queue.get: empty 2024-12-13 22:17:13,047 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb584389d80>)
2024-12-13 02:01:37,744 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,048 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:37,744 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:13,070 - DEBUG - queue.get: empty
2024-12-13 02:01:37,744 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,070 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,941 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34b9ec0>) 2024-12-13 22:17:13,071 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:37,941 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:13,071 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,944 - DEBUG - queue.get: empty 2024-12-13 22:17:13,271 - DEBUG - queue.get: empty
2024-12-13 02:01:37,944 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,271 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:37,944 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:13,272 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:37,944 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,272 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,144 - DEBUG - queue.get: empty 2024-12-13 22:17:13,472 - DEBUG - queue.get: empty
2024-12-13 02:01:38,144 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,473 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,144 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:13,473 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:38,145 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,473 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,345 - DEBUG - queue.get: empty 2024-12-13 22:17:13,674 - DEBUG - queue.get: empty
2024-12-13 02:01:38,345 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,674 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,345 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:13,674 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:38,345 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,674 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,545 - DEBUG - queue.get: empty 2024-12-13 22:17:13,875 - DEBUG - queue.get: empty
2024-12-13 02:01:38,545 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,875 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,545 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:13,875 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:38,545 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:13,876 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,746 - DEBUG - queue.get: empty 2024-12-13 22:17:14,049 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb58438a080>)
2024-12-13 02:01:38,746 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,050 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:38,746 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:14,076 - DEBUG - queue.get: empty
2024-12-13 02:01:38,746 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,077 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,942 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34ba1c0>) 2024-12-13 22:17:14,077 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:38,942 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:14,077 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,946 - DEBUG - queue.get: empty 2024-12-13 22:17:14,278 - DEBUG - queue.get: empty
2024-12-13 02:01:38,946 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,278 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:38,946 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:14,278 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:38,946 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,279 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,146 - DEBUG - queue.get: empty 2024-12-13 22:17:14,479 - DEBUG - queue.get: empty
2024-12-13 02:01:39,146 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,480 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,146 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:14,480 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:39,146 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,480 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,346 - DEBUG - queue.get: empty 2024-12-13 22:17:14,680 - DEBUG - queue.get: empty
2024-12-13 02:01:39,347 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,681 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,347 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:14,681 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:39,347 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,681 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,547 - DEBUG - queue.get: empty 2024-12-13 22:17:14,882 - DEBUG - queue.get: empty
2024-12-13 02:01:39,547 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,882 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,547 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:14,882 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:39,547 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:14,883 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,747 - DEBUG - queue.get: empty 2024-12-13 22:17:15,050 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb58438a100>)
2024-12-13 02:01:39,747 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,051 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:39,747 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:15,083 - DEBUG - queue.get: empty
2024-12-13 02:01:39,747 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,083 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,942 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34ba040>) 2024-12-13 22:17:15,083 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:39,942 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:15,084 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,948 - DEBUG - queue.get: empty 2024-12-13 22:17:15,284 - DEBUG - queue.get: empty
2024-12-13 02:01:39,948 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,285 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:39,948 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:15,285 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:39,948 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,285 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,148 - DEBUG - queue.get: empty 2024-12-13 22:17:15,485 - DEBUG - queue.get: empty
2024-12-13 02:01:40,148 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,486 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,148 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:15,486 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:40,148 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,486 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,348 - DEBUG - queue.get: empty 2024-12-13 22:17:15,686 - DEBUG - queue.get: empty
2024-12-13 02:01:40,348 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,687 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,348 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:15,687 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:40,348 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,687 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,549 - DEBUG - queue.get: empty 2024-12-13 22:17:15,888 - DEBUG - queue.get: empty
2024-12-13 02:01:40,549 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,888 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,549 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:15,888 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:40,549 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:15,888 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,749 - DEBUG - queue.get: empty 2024-12-13 22:17:16,052 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb584389d80>)
2024-12-13 02:01:40,749 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,052 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:40,749 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:16,089 - DEBUG - queue.get: empty
2024-12-13 02:01:40,749 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,089 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,943 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34b9ec0>) 2024-12-13 22:17:16,089 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:40,943 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:16,089 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,949 - DEBUG - queue.get: empty 2024-12-13 22:17:16,290 - DEBUG - queue.get: empty
2024-12-13 02:01:40,949 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,290 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:40,949 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:16,290 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:40,949 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,291 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,150 - DEBUG - queue.get: empty 2024-12-13 22:17:16,491 - DEBUG - queue.get: empty
2024-12-13 02:01:41,150 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,491 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,150 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:16,492 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:41,150 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,492 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,350 - DEBUG - queue.get: empty 2024-12-13 22:17:16,692 - DEBUG - queue.get: empty
2024-12-13 02:01:41,350 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,693 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,350 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:16,693 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:41,350 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,693 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,550 - DEBUG - queue.get: empty 2024-12-13 22:17:16,893 - DEBUG - queue.get: empty
2024-12-13 02:01:41,550 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,894 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,550 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:16,894 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:41,550 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:16,894 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,751 - DEBUG - queue.get: empty 2024-12-13 22:17:17,054 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7fb58438a080>)
2024-12-13 02:01:41,751 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:17,054 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:41,751 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:17,095 - DEBUG - queue.get: empty
2024-12-13 02:01:41,751 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:17,095 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,945 - DEBUG - socket timeout from recvMsg (<class 'TimeoutError'>, TimeoutError('timed out'), <traceback object at 0x7f38c34ba1c0>) 2024-12-13 22:17:17,095 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:41,945 - DEBUG - reader loop, recvd size 0 2024-12-13 22:17:17,096 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,951 - DEBUG - queue.get: empty 2024-12-13 22:17:17,296 - DEBUG - queue.get: empty
2024-12-13 02:01:41,951 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:17,297 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:41,951 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:17,297 - DEBUG - conn:1 queue.sz:0
2024-12-13 02:01:41,951 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:17,297 - DEBUG - 140417584002128 isConn: 2, connConnected: True
2024-12-13 02:01:42,152 - DEBUG - queue.get: empty 2024-12-13 22:17:17,353 - WARNING - Timeout while waiting for market data.
2024-12-13 02:01:42,152 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:17,353 - DEBUG - 140417584002128 connState: 2 -> 0
2024-12-13 02:01:42,152 - DEBUG - conn:1 queue.sz:0 2024-12-13 22:17:17,353 - INFO - disconnecting
2024-12-13 02:01:42,152 - DEBUG - 139881771299920 isConn: 2, connConnected: True 2024-12-13 22:17:17,353 - DEBUG - disconnecting
2024-12-13 02:01:42,322 - WARNING - Timeout while waiting for market data. 2024-12-13 22:17:17,353 - DEBUG - disconnected
2024-12-13 02:01:42,322 - DEBUG - 139881771299920 connState: 2 -> 0 2024-12-13 22:17:17,353 - INFO - Connection to IB Gateway closed.
2024-12-13 02:01:42,322 - INFO - disconnecting 2024-12-13 22:17:17,353 - DEBUG - 140417584002128 connState: None -> 0
2024-12-13 02:01:42,322 - DEBUG - disconnecting 2024-12-13 22:17:17,498 - DEBUG - queue.get: empty
2024-12-13 02:01:42,322 - DEBUG - disconnected 2024-12-13 22:17:17,498 - DEBUG - 140417584002128 isConn: 0, connConnected: None
2024-12-13 02:01:42,322 - INFO - Connection to IB Gateway closed. 2024-12-13 22:17:17,498 - DEBUG - conn:0 queue.sz:0
2024-12-13 02:01:42,323 - DEBUG - 139881771299920 connState: None -> 0 2024-12-13 22:17:17,499 - DEBUG - 140417584002128 isConn: 0, connConnected: None
2024-12-13 02:01:42,352 - DEBUG - queue.get: empty 2024-12-13 22:17:17,499 - DEBUG - 140417584002128 connState: 0 -> 0
2024-12-13 02:01:42,352 - DEBUG - 139881771299920 isConn: 0, connConnected: None 2024-12-13 22:17:18,055 - DEBUG - socket broken, disconnecting
2024-12-13 02:01:42,352 - DEBUG - conn:0 queue.sz:0 2024-12-13 22:17:18,055 - DEBUG - reader loop, recvd size 0
2024-12-13 02:01:42,352 - DEBUG - 139881771299920 isConn: 0, connConnected: None 2024-12-13 22:17:18,055 - DEBUG - EReader thread finished
2024-12-13 02:01:42,352 - DEBUG - 139881771299920 connState: 0 -> 0 2024-12-13 22:17:19,354 - INFO - TestStockRetriever completed.
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.