search

QuantConnect / lean-cli

CLI for running the LEAN engine locally and in the cloud
https://www.lean.io/cli
Apache License 2.0
196 stars 100 forks source link

Can't Run Local Live IB on Mac with M1 Chip #212

Closed DerekMelchin closed 1 year ago

DerekMelchin commented 1 year ago

If we try to run a local backtest on a Mac with an M1 chip, we get

Error: Please make sure Docker is installed and running

See this related thread.

DerekMelchin commented 1 year ago

There also seems to be an issue with IBGateway not launching on M1 Pro systems. See this forum discussion.

richmcpharlin commented 1 year ago

Logs from my issue


(base) rich@192-168-1-15 quant % lean backtest "Dancing Red-Orange Bull"
A custom engine image: "lean-cli/engine:latest" is being used!
^C
Aborted!
(base) rich@192-168-1-15 quant % lean live "Dancing Red-Orange Bull"
Select a brokerage:
1) Paper Trading
2) Interactive Brokers
3) Tradier
4) Oanda
5) Bitfinex
6) Coinbase Pro
7) Binance
8) Zerodha
9) Samco
10) Terminal Link
11) Atreyu
12) Trading Technologies
13) Kraken
14) FTX
Enter an option: 1
Configure credentials for Paper Trading
Select a data feed:
1) Interactive Brokers
2) Tradier
3) Oanda
4) Bitfinex
5) Coinbase Pro
6) Binance
7) Zerodha
8) Samco
9) Terminal Link
10) Kraken
11) FTX
12) IQFeed
13) Polygon Data Feed
14) Custom data only
To enter multiple options, separate them with comma.: 1
Configure credentials for Interactive Brokers

Select the organization with access to the Interactive Brokers feature (requires a Researcher seat or higher): Rich McPharlin
To use IB with LEAN you must disable two-factor authentication or only use IBKR Mobile. This is done from your IB Account Manage Account -> Settings -> User Settings -> Security -> Secure Login System. In the Secure Login System, deselect all options or only select "IB 
Key Security via IBKR Mobile". Interactive Brokers Lite accounts do not support API trading.

Delayed market data is used when you subscribe to data for which you don't have a market data subscription on IB. If delayed market data is disabled, live trading will stop and LEAN will shut down when this happens.
Downloading 'QuantConnect.InteractiveBrokersBrokerage.2.5.14768.nupkg'
Downloading 'QuantConnect.InteractiveBrokersBrokerage.ToolBox.2.5.14768.nupkg'
Do you want to set the initial cash balance? [y/N]: 
Do you want to set the initial portfolio holdings? [y/N]: 
A custom engine image: "lean-cli/engine:latest" is being used!
Package source with Name: Package source 1 added successfully.
The template "Solution File" was created successfully.

The template "Class Library" was created successfully.

  Determining projects to restore...
  Writing /tmp/tmpRxizLn.tmp
info : Adding PackageReference for package 'QuantConnect.InteractiveBrokersBrokerage' into project '/ModulesProject/ModulesProject.csproj'.
info : Restoring packages for /ModulesProject/ModulesProject.csproj...
info : Installed QuantConnect.InteractiveBrokersBrokerage 2.5.14768 from /Modules with content hash P0XguDqXDY0/uYqEF7P52/rl8eg9f51AUqaf4Xib4zeiNxaZjz+fr7HnpKwh2K1Qtdejs/a8xBwdLVYjMI2ZXA==.
info : Package 'QuantConnect.InteractiveBrokersBrokerage' is compatible with all the specified frameworks in project '/ModulesProject/ModulesProject.csproj'.
info : PackageReference for package 'QuantConnect.InteractiveBrokersBrokerage' version '2.5.14768' added to file '/ModulesProject/ModulesProject.csproj'.
info : Generating MSBuild file /Compile/obj/ModulesProject/ModulesProject.csproj.nuget.g.props.
info : Generating MSBuild file /Compile/obj/ModulesProject/ModulesProject.csproj.nuget.g.targets.
info : Writing assets file to disk. Path: /Compile/obj/ModulesProject/project.assets.json
log  : Restored /ModulesProject/ModulesProject.csproj (in 275 ms).
  Determining projects to restore...
  Writing /tmp/tmpQXkdbM.tmp
info : Adding PackageReference for package 'QuantConnect.InteractiveBrokersBrokerage.ToolBox' into project '/ModulesProject/ModulesProject.csproj'.
info : Restoring packages for /ModulesProject/ModulesProject.csproj...
info : Installed QuantConnect.InteractiveBrokersBrokerage.ToolBox 2.5.14768 from /Modules with content hash VActDJnbqcySu1jrfvy3//kxtGSiSMG3YsdcP1tBazbUuNVl+030w99POABnEwgCwLLAXSLJuv2BhCad1M7MTQ==.
info : Package 'QuantConnect.InteractiveBrokersBrokerage.ToolBox' is compatible with all the specified frameworks in project '/ModulesProject/ModulesProject.csproj'.
info : PackageReference for package 'QuantConnect.InteractiveBrokersBrokerage.ToolBox' version '2.5.14768' added to file '/ModulesProject/ModulesProject.csproj'.
info : Writing assets file to disk. Path: /Compile/obj/ModulesProject/project.assets.json
log  : Restored /ModulesProject/ModulesProject.csproj (in 314 ms).
20221102 22:42:17.617 TRACE:: Config.Get(): Configuration key not found. Key: plugin-directory - Using default value:
20221102 22:42:17.624 TRACE:: Composer(): Loading Assemblies from /Lean/Launcher/bin/Debug
20221102 22:42:17.699 TRACE:: Python for .NET Assembly: Python.Runtime, Version=2.0.17.0, Culture=neutral, PublicKeyToken=5000fea6cba702dd
20221102 22:42:17.706 TRACE:: Config.Get(): Configuration key not found. Key: data-directory - Using default value: ../../../Data/
20221102 22:42:17.714 TRACE:: Config.Get(): Configuration key not found. Key: version-id - Using default value:
20221102 22:42:17.715 TRACE:: Config.Get(): Configuration key not found. Key: cache-location - Using default value: /Lean/Data
20221102 22:42:17.717 TRACE:: Engine.Main(): LEAN ALGORITHMIC TRADING ENGINE v2.5.0.0 Mode: DEBUG (64bit) Host: Richs-MacBook-Pro
20221102 22:42:17.723 TRACE:: Engine.Main(): Started 10:42 PM
20221102 22:42:17.729 TRACE:: Config.Get(): Configuration key not found. Key: lean-manager-type - Using default value: LocalLeanManager
20221102 22:42:17.744 TRACE:: JobQueue.NextJob(): Selected /LeanCLI/main.py
20221102 22:42:17.794 TRACE:: Config.GetValue(): scheduled-event-leaky-bucket-capacity - Using default value: 120
20221102 22:42:17.796 TRACE:: Config.GetValue(): scheduled-event-leaky-bucket-time-interval-minutes - Using default value: 1440
20221102 22:42:17.797 TRACE:: Config.GetValue(): scheduled-event-leaky-bucket-refill-amount - Using default value: 18
20221102 22:42:17.799 TRACE:: Config.GetValue(): storage-limit - Using default value: 10737418240
20221102 22:42:17.800 TRACE:: Config.GetValue(): storage-permissions - Using default value: 3
20221102 22:42:17.814 TRACE:: Config.Get(): Configuration key not found. Key: history-provider - Using default value: SubscriptionDataReaderHistoryProvider
20221102 22:42:17.816 TRACE:: Config.Get(): Configuration key not found. Key: python-venv - Using default value:
20221102 22:42:19.072 TRACE:: Config.Get(): Configuration key not found. Key: data-permission-manager - Using default value: DataPermissionManager
20221102 22:42:19.075 TRACE:: Config.GetValue(): streamed-chart-limit - Using default value: 12
20221102 22:42:19.077 TRACE:: Config.GetValue(): streamed-chart-group-size - Using default value: 3
20221102 22:42:19.089 TRACE:: AlgorithmManager.CreateTokenBucket(): Initializing LeakyBucket: Capacity: 120 RefillAmount: 18 TimeInterval: 1440
20221102 22:42:19.093 TRACE:: Config.GetValue(): algorithm-manager-time-loop-maximum - Using default value: 20
20221102 22:42:19.103 TRACE:: Engine.Run(): Resource limits '0' CPUs. 2147483647 MB RAM.
20221102 22:42:19.105 TRACE:: TextSubscriptionDataSourceReader.SetCacheSize(): Setting cache size to 71582788 items
20221102 22:42:19.109 TRACE:: Config.GetValue(): consumer-batching-timeout-ms - Using default value: 0
20221102 22:42:19.456 TRACE:: Config.GetValue(): algorithm-creation-timeout - Using default value: 90
20221102 22:42:19.462 TRACE:: PythonInitializer.Initialize(): start...
PythonEngine.Initialize(): clr GetManifestResourceStream...
20221102 22:42:19.638 TRACE:: PythonInitializer.Initialize(): ended
20221102 22:42:19.642 TRACE:: AlgorithmPythonWrapper(): Python version 3.8.13 | packaged by conda-forge | (default, Mar 25 2022, 05:57:03)
[GCC 10.3.0]: Importing python module main
20221102 22:42:20.982 TRACE:: AlgorithmPythonWrapper(): main successfully imported.
20221102 22:42:20.987 TRACE:: AlgorithmPythonWrapper(): Creating IAlgorithm instance.
20221102 22:42:20.996 TRACE:: Config.GetValue(): api-data-update-period - Using default value: 1
20221102 22:42:21.121 TRACE:: Config.GetValue(): mute-python-library-logging - Using default value: True
20221102 22:42:21.144 TRACE:: LocalObjectStore.Initialize(): Storage Root: /Storage. StorageFileCount 9999999. StorageLimit 10240MB
20221102 22:42:21.145 TRACE:: LiveTradingDataFeed.GetDataChannelProvider(): will use DataChannelProvider
20221102 22:42:21.155 TRACE:: CompositeDataQueueHandler.SetJob(): will use [
  "QuantConnect.Brokerages.InteractiveBrokers.InteractiveBrokersBrokerage"
]
20221102 22:42:21.162 TRACE:: Config.GetValue(): ib-response-timeout - Using default value: 300
20221102 22:42:21.168 TRACE:: InteractiveBrokersBrokerage.InteractiveBrokersBrokerage(): Starting IB Automater...
20221102 22:42:21.176 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Setting execute permissions on IBAutomater.sh
20221102 22:42:21.186 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): chmod +x IBAutomater.sh: process exit code: 0
20221102 22:42:21.189 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Loading IBGateway - Version: 985 - Path: /root/ibgateway - User: *****
20221102 22:42:21.191 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Searching for TWS JRE path
20221102 22:42:21.193 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Install4J path: /root/ibgateway/.install4j
20221102 22:42:21.194 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): File not found: /root/ibgateway/.install4j/pref_jre.cfg
20221102 22:42:21.197 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): File found: /root/ibgateway/.install4j/inst_jre.cfg
20221102 22:42:21.199 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Directory found: /usr/lib/jvm/java-8-openjdk-arm64/jre
20221102 22:42:21.200 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Updating IBGateway ini file: /root/Jts/jts.ini
20221102 22:42:21.206 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Updating IBGateway configuration file: /root/ibgateway/ibgateway.vmoptions
20221102 22:42:21.213 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): IBAutomater process started - Id:155 - Name:IBAutomater.sh - InitializationTimeout:00:15:00
20221102 22:42:21.219 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): UID        PID  PPID  C    SZ   RSS PSR STIME TTY          TIME CMD
20221102 22:42:21.221 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): root         1     0 50 5706452 342080 1 22:42 pts/0   00:00:04 dotnet QuantConnect.Lean.Launcher.dll
20221102 22:42:21.222 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): root       155     1  0  2379  2844   2 22:42 pts/0    00:00:00   /bin/bash /Lean/Launcher/bin/Debug/IBAutomater.sh /root/ibgateway
20221102 22:42:21.224 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): root       156   155  0  2844  2708   0 22:42 pts/0    00:00:00     ps -AFH
20221102 22:42:26.243 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): UID        PID  PPID  C    SZ   RSS PSR STIME TTY          TIME CMD
20221102 22:42:26.255 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): root         1     0 32 5706452 342576 1 22:42 pts/0   00:00:04 dotnet QuantConnect.Lean.Launcher.dll
20221102 22:42:26.259 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): root       155     1  0  2379  3052   1 22:42 pts/0    00:00:00   /bin/bash /Lean/Launcher/bin/Debug/IBAutomater.sh /root/ibgateway
20221102 22:42:26.262 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): root       160   155  0  2844  2664   3 22:42 pts/0    00:00:00     ps -AFH
20221102 22:42:27.212 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): IBGateway started
 20221102 23:01:42.765 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): IB launcher log file: /root/Jts/launcher.log
20221102 23:01:42.778 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.034 [FA] INFO  [JTS-Main] - OvernightManager.dayInit: new values: dayOfTheWeek: 4 (Wed), YYYYMMofToday: 202211, YYYYMMDDofToday:
20221102, m_todayDate: 20221102, dueToChangeInTimezone: false
20221102 23:01:42.783 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.036 [FA] INFO  [JTS-Main] - Created on: 20221102
20221102 23:01:42.790 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.036 [FA] INFO  [JTS-Main] - ------------------------------- IB GATEWAY RESTART --------------------------------
20221102 23:01:42.797 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.037 [FA] INFO  [JTS-Main] - installer version: 2.95, installer type: standalone, install dir: '/root/ibgateway/', Jts dir: 
'/root/Jts', VM options file: '/root/ibgateway/ibgateway.vmoptions'
20221102 23:01:42.799 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.045 [FA] INFO  [JTS-Main] - Verifying environment [entryPoint=IBGATEWAY_STANDALONE]...
20221102 23:01:42.803 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.059 [FA] INFO  [AWT-EventQueue-0] - Install4jAutoUpdateService initialized 
[props=LauncherProperties[updateDownloadUrl=null,skipUpdateCheck=false,nightlyEnabled=true,channelNameArg=null,channelName=latest,channelChanged=false,jtsConfigDir=/root/Jts,apiPort=null,sessionId=null,installDir=/root/ibgateway/,exeName=null]].
20221102 23:01:42.806 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.064 [FA] INFO  [JTS-Main] - PROXY Installed custom selector
20221102 23:01:42.808 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.070 [FA] INFO  [JTS-Main] - useSsl=true,FIX endPoint=null:4001
20221102 23:01:42.811 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.072 [FA] INFO  [JTS-Main] - LOCALE: Property locale_to_use=null
20221102 23:01:42.813 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.074 [FA] INFO  [JTS-Main] - LOCALE: JTS Locale=en_US  country=United States  variant=
20221102 23:01:42.816 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.075 [FA] INFO  [JTS-Main] - Region: America
20221102 23:01:42.819 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.078 [FA] INFO  [JTS-Main] - 
DocumentBuilderFactory=jar:file:/usr/lib/jvm/java-8-openjdk-arm64/jre/lib/rt.jar!/com/sun/org/apache/xerces/internal/jaxp/DocumentBuilderFactoryImpl.class
20221102 23:01:42.820 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.160 [FA] INFO  [JTS-Main] - LOCALE: loaded 9 supported locales
20221102 23:01:42.821 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.237 [FA] INFO  [JTS-Main] - LOCALE: loaded 8 countries
20221102 23:01:42.823 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.241 [FA] INFO  [JTS-Main] - LOCALE: from OS: en_US
20221102 23:01:42.825 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.241 [FA] INFO  [JTS-Main] - LOCALE: created classloader java.net.URLClassLoader@2b4bac49 with 
file:/root/ibgateway/jars/locales.jar, parent: sun.misc.Launcher$AppClassLoader@18b4aac2
20221102 23:01:42.827 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.241 [FA] INFO  [JTS-Main] - Locale=en_US  country=United States  variant=
20221102 23:01:42.829 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.243 [FA] INFO  [JTS-Main] - prohibiting class lookup [twslaunch.ji18n.LauncherLanguage]
20221102 23:01:42.830 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.244 [FA] INFO  [JTS-Main] - prohibiting class lookup [twslaunch.ji18n.LauncherLanguage_en]
20221102 23:01:42.833 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.244 [FA] INFO  [JTS-Main] - prohibiting class lookup [twslaunch.ji18n.LauncherLanguage_en_US]
20221102 23:01:42.836 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.244 [FA] INFO  [JTS-Main] - LOCALE:  type: launcher intended: en_US actual:  size: 443
20221102 23:01:42.837 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.244 [FA] INFO  [JTS-Main] - settings dir: '/root/Jts'
20221102 23:01:42.839 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.245 [FA] ERROR [JTS-Main] - Error during FX Thread start up, this may result in problem described in bz87660 to reacquire
20221102 23:01:42.840 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] java.lang.NullPointerException
20221102 23:01:42.842 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at twslaunch.trader.common.f.a(f.java:888)
20221102 23:01:42.843 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at twslaunch.trader.common.f.k(f.java:973)
20221102 23:01:42.845 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at ibgateway.GWClient.a(Unknown Source)
20221102 23:01:42.846 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at ibgateway.GWClient.main(Unknown Source)
20221102 23:01:42.849 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
20221102 23:01:42.851 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
20221102 23:01:42.852 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
20221102 23:01:42.854 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.lang.reflect.Method.invoke(Method.java:498)
20221102 23:01:42.857 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at com.exe4j.runtime.LauncherEngine.launch(LauncherEngine.java:84)
20221102 23:01:42.859 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at com.install4j.runtime.launcher.UnixLauncher.start(UnixLauncher.java:66)
20221102 23:01:42.861 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at install4j.ibgateway.GWClient.main(Unknown Source)
20221102 23:01:42.863 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.246 [FA] INFO  [JTS-Main] - LauncherFontUpdater: simulatehighdefscreen=false
20221102 23:01:42.883 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.246 [FA] INFO  [JTS-Main] - LauncherFontUpdater: Screen dimensions=1024x768
20221102 23:01:42.885 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.246 [FA] INFO  [JTS-Main] - LauncherFontUpdater: highres=false
20221102 23:01:42.887 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.246 [FA] INFO  [JTS-Main] - LauncherFontUpdater: FontSize=16
20221102 23:01:42.889 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.249 [FA] INFO  [JTS-Main] - initPreUI() - entry
20221102 23:01:42.890 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.253 [FA] INFO  [JTS-Main] - Build 10.12.2d, Dec 21, 2021 7:29:02 PM
20221102 23:01:42.893 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.271 [FA] INFO  [JTS-Main] - LookAndFeelChangedListener installed
20221102 23:01:42.894 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.274 [FA] INFO  [JTS-Main] - JtsLookAndFeel initialized
20221102 23:01:42.896 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.485 [FA] INFO  [JTS-Main] - Current LAF: TWS LAF
20221102 23:01:42.897 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.486 [FA] INFO  [JTS-Main] - initPreUI() - exit
20221102 23:01:42.898 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.490 [FA] INFO  [JTS-MiscUlrsRequester-5] - Connecting ndc1.ibllc.com:4000 timeout=0...
20221102 23:01:42.900 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.932 [FA] ERROR [AWT-EventQueue-0] - Error
20221102 23:01:42.902 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] java.lang.NoClassDefFoundError: javafx/embed/swing/JFXPanel
20221102 23:01:42.903 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at twslaunch.jclient.bk.<init>(bk.java:696)
20221102 23:01:42.908 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at ibgateway.aB.<init>(Unknown Source)
20221102 23:01:42.910 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at ibgateway.GWClient.a(Unknown Source)
20221102 23:01:42.911 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.event.InvocationEvent.dispatch(InvocationEvent.java:311)
20221102 23:01:42.912 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventQueue.dispatchEventImpl(EventQueue.java:758)
20221102 23:01:42.914 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventQueue.access$500(EventQueue.java:97)
20221102 23:01:42.915 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventQueue$3.run(EventQueue.java:709)
20221102 23:01:42.917 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventQueue$3.run(EventQueue.java:703)
20221102 23:01:42.918 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.security.AccessController.doPrivileged(Native Method)
20221102 23:01:42.919 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.security.ProtectionDomain$JavaSecurityAccessImpl.doIntersectionPrivilege(ProtectionDomain.java:74)
20221102 23:01:42.921 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventQueue.dispatchEvent(EventQueue.java:728)
20221102 23:01:42.928 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventDispatchThread.pumpOneEventForFilters(EventDispatchThread.java:205)
20221102 23:01:42.929 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventDispatchThread.pumpEventsForFilter(EventDispatchThread.java:116)
20221102 23:01:42.931 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventDispatchThread.pumpEventsForHierarchy(EventDispatchThread.java:105)
20221102 23:01:42.932 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:101)
20221102 23:01:42.933 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventDispatchThread.pumpEvents(EventDispatchThread.java:93)
20221102 23:01:42.935 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.awt.EventDispatchThread.run(EventDispatchThread.java:82)
20221102 23:01:42.937 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Caused by: java.lang.ClassNotFoundException: javafx.embed.swing.JFXPanel
20221102 23:01:42.939 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.net.URLClassLoader.findClass(URLClassLoader.java:387)
20221102 23:01:42.945 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.lang.ClassLoader.loadClass(ClassLoader.java:418)
20221102 23:01:42.947 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:352)
20221102 23:01:42.949 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      at java.lang.ClassLoader.loadClass(ClassLoader.java:351)
20221102 23:01:42.951 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher]      ... 17 more
20221102 23:01:42.952 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.940 [FA] INFO  [JTS-MiscUlrsRequester-5] - Connected to ndc1.ibllc.com:4000 on local port 0 socket local addrs:port 
/172.18.0.2:33492
20221102 23:01:42.953 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.941 [FA] INFO  [JTS-MiscUlrsRequester-5] - Resolving mac address
20221102 23:01:42.955 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.941 [FA] INFO  [JTS-MiscUlrsRequester-5] - MACNetworkInfo created <eb7bf553|02:42:AC:12:00:02|172.18.0.2>
20221102 23:01:42.957 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.945 [FA] INFO  [JTS-MISC URLsListenerS1-6] - Starting listener thread [sessionID=1]...
20221102 23:01:42.958 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:27.953 [FA] INFO  [JTS-MiscUlrsRequester-5] - Sending MiscUrls request
20221102 23:01:42.959 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.042 [FA] INFO  [JTS-MiscUlrsRequester-5] - LOGIN_TIME_MONITOR     false 22:42:28:041 since start = 0 thread delay = 0 global 
delay = -1 tag=null, cls=AuthDispatcher method=send
20221102 23:01:42.961 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.044 [FA] INFO  [JTS-MISC URLsListenerS1-6] - Initial listener buffer size is 65536.
20221102 23:01:42.962 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.044 [FA] INFO  [JTS-MISC URLsListenerS1-6] - Listener thread [sessionID=1] is ready to process messages.
20221102 23:01:42.964 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.044 [FA] INFO  [JTS-AuthDispatcherS1-7] - Starting dispatcher thread [sessionID=1]...
20221102 23:01:42.965 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.043 [FA] INFO  [JTS-AuthResponseMonitor-8] - Starting auth response monitor thread
20221102 23:01:42.966 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.360 [FA] INFO  [JTS-AuthDispatcherS1-7] - Received NS_MISC_URLS
20221102 23:01:42.967 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.367 [FA] INFO  [JTS-AuthDispatcherS1-7] - Misc URL: scope is blank - setting userScope to EXTERNAL
20221102 23:01:42.970 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.368 [FA] INFO  [JTS-AuthDispatcherS1-7] - Misc URL: setting userScope to EXTERNAL
20221102 23:01:42.971 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.381 [FA] INFO  [JTS-AuthDispatcherS1-7] - Disconnecting ndc1.ibllc.com:4000 
[disconnectDetails=DisconnectDetails[sessionID=1,endPoint=ndc1.ibllc.com:4000,reason=DISCONNECT_BY_DESIGN,cause=null,systemMessage=null,keepSocketOpen=false]]...
20221102 23:01:42.972 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.382 [FA] INFO  [JTS-AuthDispatcherS1-7] - Socket closed.
20221102 23:01:42.974 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.382 [FA] INFO  [JTS-AuthDispatcherS1-7] - Interrupting dispatcher [sessionID=1]...
20221102 23:01:42.975 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.382 [FA] INFO  [JTS-AuthDispatcherS1-7] - Interrupting listener [sessionID=1,disconnectSocket=true]...
20221102 23:01:42.977 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.383 [FA] INFO  [JTS-MISC URLsListenerS1-6] - Socket or stream for connection ndc1.ibllc.com:4000 was closed by another thread.
20221102 23:01:42.979 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.383 [FA] INFO  [JTS-AuthDispatcherS1-7] - Dispatcher thread terminating [sessionID=1,interrupted=true]...
20221102 23:01:42.980 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.383 [FA] INFO  [JTS-MISC URLsListenerS1-6] - Listener thread terminating [sessionID=1] 
[seen=1168,totalShifted=1168,moreAvailable=0]
20221102 23:01:42.981 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:28.384 [FA] INFO  [JTS-AuthResponseMonitor-8] - Terminating auth response monitor thread
20221102 23:01:42.983 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:32.066 [FA] INFO  [JTS-DeadlockMonitor-2] - Memory:total=786,432KB free=763,594KB HeapUsage: Max=786,432KB used=21,299KB 
committed=253,952KB NonHeapUsage: Max=0KB used=46,706KB committed=48,120KB
20221102 23:01:42.984 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:42:33.081 [FA] INFO  [JTS-DeadlockMonitor-2] - CPU:cur=0.15% avg=0.15% 30 min avg=0.15% 10 min avg=0.15% 5 min avg=0.15% 1 min 
avg=0.15%
20221102 23:01:42.986 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] GC:called=3 times CPU used=0.65%
20221102 23:01:42.987 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Finalizer:cur=0.00% avg=0.00% 30 min avg=0.00% 10 min avg=0.00% 5 min avg=0.00% 1 min avg=0.00%
20221102 23:01:42.989 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Threads Count:curr live=14 curr daemon=12
20221102 23:01:42.991 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:47:32.236 [FA] INFO  [JTS-DeadlockMonitor-2] - Memory:total=786,432KB free=762,570KB HeapUsage: Max=786,432KB used=22,323KB 
committed=253,952KB NonHeapUsage: Max=0KB used=46,248KB committed=48,120KB
20221102 23:01:42.992 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:47:33.256 [FA] INFO  [JTS-DeadlockMonitor-2] - CPU:cur=0.02% avg=0.04% 30 min avg=0.04% 10 min avg=0.04% 5 min avg=0.04% 1 min 
avg=0.03%
20221102 23:01:42.993 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] GC:called=3 times CPU used=0.01%
20221102 23:01:42.995 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Finalizer:cur=0.00% avg=0.00% 30 min avg=0.00% 10 min avg=0.00% 5 min avg=0.00% 1 min avg=0.00%
20221102 23:01:42.998 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Threads Count:curr live=13 curr daemon=11
20221102 23:01:43.000 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:54:02.737 [FA] INFO  [JTS-DeadlockMonitor-2] - Memory:total=786,432KB free=762,570KB HeapUsage: Max=786,432KB used=22,323KB 
committed=253,952KB NonHeapUsage: Max=0KB used=46,081KB committed=48,120KB
20221102 23:01:43.001 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:54:03.744 [FA] INFO  [JTS-DeadlockMonitor-2] - CPU:cur=0.03% avg=0.04% 30 min avg=0.04% 10 min avg=0.04% 5 min avg=0.03% 1 min 
avg=0.03%
20221102 23:01:43.002 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] GC:called=3 times CPU used=0.01%
20221102 23:01:43.003 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Finalizer:cur=0.00% avg=0.00% 30 min avg=0.00% 10 min avg=0.00% 5 min avg=0.00% 1 min avg=0.00%
20221102 23:01:43.005 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Threads Count:curr live=13 curr daemon=11
20221102 23:01:43.005 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:59:04.343 [FA] INFO  [JTS-DeadlockMonitor-2] - Memory:total=786,432KB free=762,060KB HeapUsage: Max=786,432KB used=22,323KB 
committed=253,952KB NonHeapUsage: Max=0KB used=46,150KB committed=48,120KB
20221102 23:01:43.006 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] 2022-11-02 22:59:05.354 [FA] INFO  [JTS-DeadlockMonitor-2] - CPU:cur=0.03% avg=0.04% 30 min avg=0.04% 10 min avg=0.03% 5 min avg=0.04% 1 min 
avg=0.04%
20221102 23:01:43.007 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] GC:called=3 times CPU used=0.01%
20221102 23:01:43.008 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Finalizer:cur=0.00% avg=0.00% 30 min avg=0.00% 10 min avg=0.00% 5 min avg=0.00% 1 min avg=0.00%
20221102 23:01:43.010 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): [IB Launcher] Threads Count:curr live=13 curr daemon=11
20221102 23:01:43.012 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): IB Automater initialization timeout.
20221102 23:01:43.033 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): IBAutomater error - Code: InitializationTimeout Message: The IBAutomater initialization timed out.
20221102 23:01:43.041 ERROR:: Brokerage.OnMessage(): Error - Code: InitializationTimeout - The IBAutomater initialization timed out.
20221102 23:01:43.065 ERROR:: Engine.Run():  System.Exception: InteractiveBrokersBrokerage.CheckIbAutomaterError(): InitializationTimeout - The IBAutomater initialization timed out.
   at QuantConnect.Brokerages.InteractiveBrokers.InteractiveBrokersBrokerage.a(StartResult A_0, Boolean A_1)
   at QuantConnect.Brokerages.InteractiveBrokers.InteractiveBrokersBrokerage.a(IAlgorithm A_0, IOrderProvider A_1, ISecurityProvider A_2, IDataAggregator A_3, IMapFileProvider A_4, String A_5, String A_6, Int32 A_7, String A_8, String A_9, String A_10, 
String A_11, String A_12, String A_13, Boolean A_14)
   at QuantConnect.Brokerages.InteractiveBrokers.InteractiveBrokersBrokerage.SetJob(LiveNodePacket job)
   at QuantConnect.Lean.Engine.DataFeeds.DataQueueHandlerManager.SetJob(LiveNodePacket job) in /LeanCLI/Lean/Engine/DataFeeds/DataQueueHandlerManager.cs:line 114
   at QuantConnect.Lean.Engine.DataFeeds.LiveTradingDataFeed.Initialize(IAlgorithm algorithm, AlgorithmNodePacket job, IResultHandler resultHandler, IMapFileProvider mapFileProvider, IFactorFileProvider factorFileProvider, IDataProvider dataProvider, 
IDataFeedSubscriptionManager subscriptionManager, IDataFeedTimeProvider dataFeedTimeProvider, IDataChannelProvider dataChannelProvider) in /LeanCLI/Lean/Engine/DataFeeds/LiveTradingDataFeed.cs:line 97
   at QuantConnect.Lean.Engine.Engine.Run(AlgorithmNodePacket job, AlgorithmManager manager, String assemblyPath, WorkerThread workerThread) in /LeanCLI/Lean/Engine/Engine.cs:line 174
20221102 23:01:43.078 TRACE:: JOB HANDLERS:
         DataFeed:             QuantConnect.Lean.Engine.DataFeeds.LiveTradingDataFeed
         Setup:                QuantConnect.Lean.Engine.Setup.BrokerageSetupHandler
         RealTime:             QuantConnect.Lean.Engine.RealTime.LiveTradingRealTimeHandler
         Results:              QuantConnect.Lean.Engine.Results.LiveTradingResultHandler
         Transactions:         QuantConnect.Lean.Engine.TransactionHandlers.BacktestingTransactionHandler
         Alpha:                QuantConnect.Lean.Engine.Alphas.DefaultAlphaHandler
         Object Store:         QuantConnect.Lean.Engine.Storage.LocalObjectStore
         History Provider:
         Brokerage:            QuantConnect.Brokerages.Paper.PaperBrokerage
         Data Provider:        QuantConnect.Lean.Engine.DataFeeds.DefaultDataProvider

20221102 23:01:43.081 TRACE:: StopSafely(): waiting for 'RealTimeScheduleEventService' thread to stop...
20221102 23:01:43.083 TRACE:: DefaultAlphaHandler.Exit(): Exiting...
20221102 23:01:43.091 TRACE:: DefaultAlphaHandler.Exit(): Ended
20221102 23:01:43.109 ERROR:: Algorithm.Initialize() Error: InteractiveBrokersBrokerage.CheckIbAutomaterError(): InitializationTimeout - The IBAutomater initialization timed out. Stack Trace: InteractiveBrokersBrokerage.CheckIbAutomaterError():
InitializationTimeout - The IBAutomater initialization timed out.
 InteractiveBrokersBrokerage.CheckIbAutomaterError(): InitializationTimeout - The IBAutomater initialization timed out.
20221102 23:01:43.115 TRACE:: LiveTradingResultHandler.Run(): Ending Thread...
20221102 23:01:43.121 TRACE:: StopSafely(): waiting for 'Result Thread' thread to stop...
20221102 23:01:43.123 TRACE:: LiveTradingResultHandler.SendFinalResult(): Starting...
20221102 23:01:43.201 TRACE:: LiveTradingResultHandler.SendFinalResult(): Finished storing results. Start sending...
20221102 23:01:43.202 TRACE:: LiveTradingResultHandler.SendFinalResult(): Ended
20221102 23:01:43.205 TRACE:: Engine.Run(): Disconnecting from brokerage...
20221102 23:01:43.206 TRACE:: Engine.Run(): Disposing of setup handler...
20221102 23:01:43.208 TRACE:: BrokerageSetupHandler.Setup(): Found data queue handler to dispose: QuantConnect.Brokerages.InteractiveBrokers.InteractiveBrokersBrokerage
20221102 23:01:43.211 TRACE:: InteractiveBrokersBrokerage.Dispose(): Disposing of IB resources.
20221102 23:01:43.216 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): Updating IBGateway configuration file: /root/ibgateway/ibgateway.vmoptions
20221102 23:01:43.222 TRACE:: Engine.Main(): Analysis Completed and Results Posted.
Engine.Main(): Analysis Complete.
20221102 23:01:43.224 TRACE:: Engine.Main(): Packet removed from queue: L-3128468899
20221102 23:01:43.225 TRACE:: LeanEngineSystemHandlers.Dispose(): start...
20221102 23:01:43.232 TRACE:: LeanEngineSystemHandlers.Dispose(): Disposed of system handlers.
20221102 23:01:43.235 TRACE:: LeanEngineAlgorithmHandlers.Dispose(): start...
20221102 23:01:43.237 TRACE:: BrokerageSetupHandler.Setup(): Found data queue handler to dispose: QuantConnect.Brokerages.InteractiveBrokers.InteractiveBrokersBrokerage
20221102 23:01:43.238 TRACE:: LeanEngineAlgorithmHandlers.Dispose(): Disposed of algorithm handlers.
20221102 23:01:43.241 TRACE:: StopSafely(): waiting for 'CpuPerformance' thread to stop...
20221102 23:01:43.241 TRACE:: PythonInitializer.Shutdown(): start
20221102 23:01:43.471 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterOutputDataReceived(): IBGateway process exited
20221102 23:01:43.476 TRACE:: InteractiveBrokersBrokerage.OnIbAutomaterExited(): Exit code: 0
20221102 23:01:43.477 ERROR:: Brokerage.OnMessage(): Error - Code: InitializationTimeout - The IBAutomater initialization timed out.
20221102 23:01:44.758 TRACE:: PythonInitializer.Shutdown(): ended
20221102 23:01:44.758 TRACE:: Program.Main(): Exiting Lean...
Error: Something went wrong while running 'Dancing Red-Orange Bull' in the 'lean-cli' environment, the output is stored in 'Dancing Red-Orange Bull/live/2022-11-03_09-41-49'
`
Martin-Molinero commented 1 year ago

Related to https://github.com/QuantConnect/Lean/issues/6707

Martin-Molinero commented 1 year ago
Martin-Molinero commented 1 year ago

After some testing we've been able to get this working using the amd64 lean image taking advantage of the qemu emulator. The only thing required is pulling the amd64 image and lean CLI will use it instead.

# docker pull --platform linux/amd64 quantconnect/lean

In some cases we've seen the container hang, so to achieve the best performance and stability we recommend using colima which will use the latest stable qemu version. Steps:

# brew install colima
# colima start --cpu 4 --memory 8

Verifications

# qemu-img --version
qemu-img version 7.1.0 (or higher)
# docker context ls
    should show colima as selected
# docker inspect quantconnect/lean
    should show amd64 arch
# docker exec -it {lean container id} bash
    # uname -a
        should should x86_x64/amd64 or similar

Troubleshoot