RapidMiner Server - R Script not found
Dear Community,
I recently installed RM Server 9.2.1 on the Windows computer I connect remotely. I am able to run all processes, except ones with the Execute R operator. The RapidMiner Studio is installed on that machine and references the same Rscript.exe. Studio - works. Server - not.
Error I get is:
Rscript not found
Failed to detect Rscript at the given path.
Process[1] (Process)
subprocess 'Main Process'
==> +- Execute R[1] (Execute R)
<html>Please adjust the Rscript path in the Preferences.<br>(Tools -> Preferences -> R Scripting)</html>
My configuration entry:
rapidminer.r_scripting.path
points to:
C:\Program Files\R\R-3.5.3\bin\x64\Rscript.exe
(also tried to install R in other destinations and also to reference the 32-bit Rscript.exe)
I copied the extension rmx_r_scripting-9.1.0.jar from my computer to the server in the rapidminer-server-home/resources/extensions directory.
Please, let me know if there is any solution for me. I also attach the error log hoping anybody can help.
Regards
Maciek
2019-04-02 00:44:15.238 INFO 4656 --- [main] c.r.execution.jobcontainer.Application : Starting Application on G-Tower with PID 4656 (D:\MARCIN\rapidminer-server\rapidminer-server-9.2.1\job-agent\lib\container\rapidminer-jobcontainer-0.6.3.jar started by G-TOWER$ in 
\MARCIN\rapidminer-server\rapidminer-server-9.2.1\bin)
2019-04-02 00:44:15.241 INFO 4656 --- [main] c.r.execution.jobcontainer.Application : No active profile set, falling back to default profiles: default
2019-04-02 00:44:15.400 INFO 4656 --- [main] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@7eac9008: startup date [Tue Apr 02 00:44:15 CEST 2019]; root of context hierarchy
2019-04-02 00:44:16.284 INFO 4656 --- [main] o.s.s.c.ThreadPoolTaskScheduler : Initializing ExecutorService 'taskScheduler'
2019-04-02 00:44:16.895 INFO 4656 --- [main] o.s.j.e.a.AnnotationMBeanExporter : Registering beans for JMX exposure on startup
2019-04-02 00:44:16.901 INFO 4656 --- [main] o.s.c.support.DefaultLifecycleProcessor : Starting beans in phase 0
2019-04-02 00:44:16.943 INFO 4656 --- [taskScheduler-2] c.r.e.j.service.RemoteRepositoryService : Trying to update JWT token from auth properties.
2019-04-02 00:44:16.944 INFO 4656 --- [taskScheduler-2] c.r.e.j.service.RemoteRepositoryService : Updated JWT token from auth properties file.
2019-04-02 00:44:16.943 INFO 4656 --- [taskScheduler-1] c.r.e.j.service.OutOfMemoryWatchdog : Current memory usage is 544MB / 4064MB
2019-04-02 00:44:16.949 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Changing 'user.home' system property to 'D:\Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\data\jobs\21b3e330-6cf4-4eee-9d71-54cc0604de0b'
2019-04-02 00:44:16.949 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Generating new in-memory cipher key
2019-04-02 00:44:17.063 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Setting pre-defined RapidMiner properties from 'D:\Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\data\jobs\21b3e330-6cf4-4eee-9d71-54cc0604de0b\rapidminer.properties'
2019-04-02 00:44:17.216 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Initializing the RapidMiner Core
2019-04-02 00:44:17.216 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Setting execution mode to 'JOB_CONTAINER'
2019-04-02 00:44:17.228 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Loading bundled extension from 'D:\MARCIN\rapidminer-server\rapidminer-server-9.2.1\job-agent\bin\..\lib\container\plugins'
2019-04-02 00:44:17.228 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Loading custom extensions from 'D:\Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions'
2019-04-02 00:44:17.329 INFO 4656 --- [main] com.rapidminer : Set locale to en.
2019-04-02 00:44:17.357 INFO 4656 --- [main] PlatformUtilities : rapidminer.home is 'D:\MARCIN\rapidminer-server\rapidminer-server-9.2.1\job-agent\bin\..\lib\container'.
2019-04-02 00:44:17.365 INFO 4656 --- [main] com.rapidminer : Initializing license manager.
2019-04-02 00:44:17.409 INFO 4656 --- [main] com.rapidminer : Cannot access file system in execution mode JOB_CONTAINER. Not loading repositories.
2019-04-02 00:44:17.819 INFO 4656 --- [main] com.rapidminer : Register plugin: Advanced File Connectors
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Blending
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Browser
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Cloud Connectivity
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Concurrency
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: H2O
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: HTML5 Charts
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: JDBC Connectors
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Legacy Result Access
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Model Simulator
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: PMML
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Process Scheduling
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Productivity
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Professional
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Remote Repository
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Social Media
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Time Series
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Utility
2019-04-02 00:44:17.829 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Statistics Extension in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_stat-2.2.543.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_stat-2.1.692.jar. Keeping extension with version 2.2.543.
2019-04-02 00:44:17.846 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Text Processing in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_text-8.1.0.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_text-7.4.1.jar. Keeping extension with version 8.1.0.
2019-04-02 00:44:17.864 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Jackhammer Extension in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_toolkit-2.2.572.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_toolkit-2.2.430.jar. Keeping extension with version 2.2.572.
2019-04-02 00:44:17.943 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Web Mining in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_web-9.0.0.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_web-7.3.0.jar. Keeping extension with version 9.0.0.
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Advanced Reporting Extension
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: recommenders
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Keras
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Reporting
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: R Scripting
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Value Series
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Statistics Extension
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Text Processing
2019-04-02 00:44:17.945 INFO 4656 --- [main] com.rapidminer : Register plugin: Jackhammer Extension
2019-04-02 00:44:17.945 INFO 4656 --- [main] com.rapidminer : Register plugin: Web Mining
2019-04-02 00:44:18.685 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: Using Server-FallBack for License Key...
2019-04-02 00:44:18.685 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: No License Key found!
2019-04-02 00:44:18.685 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: Using Server-FallBack for Licensee...
2019-04-02 00:44:18.685 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: No Licensee Email found!
2019-04-02 00:44:18.737 INFO 4656 --- [main] com.rapidminer : Registered configurator Remote File Connection.
2019-04-02 00:44:19.057 INFO 4656 --- [main] com.rapidminer : Registered configurator Twitter Connection.
2019-04-02 00:44:19.068 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: Using Server-FallBack for License Key...
2019-04-02 00:44:19.068 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: No License Key found!
2019-04-02 00:44:19.068 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: Using Server-FallBack for Licensee...
2019-04-02 00:44:19.068 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: No Licensee Email found!
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Salesforce Connection.
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Amazon S3 Connection.
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Azure Blob Storage Connection.
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Azure Data Lake Storage Gen1 Connection.
2019-04-02 00:44:20.096 INFO 4656 --- [main] com.rapidminer : Registered configurator Google Cloud Storage Connection.
2019-04-02 00:44:20.096 INFO 4656 --- [main] com.rapidminer : Registered configurator Dropbox Connection.
2019-04-02 00:44:20.910 WARN 4656 --- [main] com.rapidminer : Missing database driver class name for ODBC Bridge (e.g. Access)
2019-04-02 00:44:20.911 WARN 4656 --- [main] com.rapidminer : Missing database driver class name for Ingres
2019-04-02 00:44:21.491 INFO 4656 --- [main] com.rapidminer : Registered 'Time Series' as sample folder.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Reporting was loaded in 4ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension PMML was loaded in 4ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Value Series was loaded in 6ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Keras was loaded in 8ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Advanced Reporting Extension was loaded in 18ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Statistics Extension was loaded in 25ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension recommenders was loaded in 35ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Text Processing was loaded in 39ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Process Scheduling was loaded in 88ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Social Media was loaded in 93ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Professional was loaded in 93ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Blending was loaded in 100ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Advanced File Connectors was loaded in 103ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Productivity was loaded in 105ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Jackhammer Extension was loaded in 105ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Concurrency was loaded in 109ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Remote Repository was loaded in 109ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Legacy Result Access was loaded in 109ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Utility was loaded in 122ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Browser was loaded in 123ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension R Scripting was loaded in 137ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension HTML5 Charts was loaded in 142ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Model Simulator was loaded in 148ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Time Series was loaded in 167ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension JDBC Connectors was loaded in 205ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Cloud Connectivity was loaded in 445ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension H2O was loaded in 479ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Web Mining was loaded in 594ms.
2019-04-02 00:44:21.947 INFO 4656 --- [taskScheduler-2] c.r.e.j.service.OutOfMemoryWatchdog : Current memory usage is 1696MB / 4064MB
2019-04-02 00:44:26.967 INFO 4656 --- [taskScheduler-1] c.r.e.j.service.OutOfMemoryWatchdog : Current memory usage is 3328MB / 4064MB
2019-04-02 00:44:28.136 INFO 4656 --- [main] com.rapidminer : Cannot access file system in execution mode JOB_CONTAINER. Not loading repositories.
2019-04-02 00:44:28.140 INFO 4656 --- [main] com.rapidminer : Load configuration for Remote File Connection.
2019-04-02 00:44:28.140 INFO 4656 --- [main] com.rapidminer : No configuration file found for Remote File Connection
2019-04-02 00:44:28.141 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Remote File Connection.
2019-04-02 00:44:28.141 INFO 4656 --- [main] com.rapidminer : Load configuration for Amazon S3 Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : No configuration file found for Amazon S3 Connection
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Amazon S3 Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Load configuration for Azure Blob Storage Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : No configuration file found for Azure Blob Storage Connection
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Azure Blob Storage Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Load configuration for Azure Data Lake Storage Gen1 Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : No configuration file found for Azure Data Lake Storage Gen1 Connection
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Azure Data Lake Storage Gen1 Connection.
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Load configuration for Dropbox Connection.
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : No configuration file found for Dropbox Connection
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Dropbox Connection.
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Load configuration for Salesforce Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : No configuration file found for Salesforce Connection
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Salesforce Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Load configuration for Google Cloud Storage Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : No configuration file found for Google Cloud Storage Connection
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Google Cloud Storage Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Load configuration for Twitter Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : No configuration file found for Twitter Connection
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Twitter Connection.
2019-04-02 00:44:28.145 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : License framework initialized. Current active license edition is 'non-commercial'. The license expires on '2020-01-24'.
2019-04-02 00:44:28.145 INFO 4656 --- [main] c.r.execution.jobcontainer.EngineRunner : Starting execution of process with job ID '21b3e330-6cf4-4eee-9d71-54cc0604de0b' for user 'admin'.
2019-04-02 00:44:28.146 INFO 4656 --- [main] c.r.e.j.service.RepositoryService : Executed process is stored in '/home/admin/Rankings/processes/Test'.
2019-04-02 00:44:28.147 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : Trying to update JWT token from auth properties.
2019-04-02 00:44:28.147 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : Skipped updating the JWT token as old one equals the new one.
2019-04-02 00:44:28.147 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : Initializing the connection to RapidMiner Server. Using protocol 'http', host '127.0.0.1', and port '8080'
2019-04-02 00:44:28.174 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Remote File Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.180 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Amazon S3 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.185 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Blob Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.190 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Data Lake Storage Gen1 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.195 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Dropbox Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.201 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Salesforce Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.205 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Google Cloud Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.211 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Twitter Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.273 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Remote File Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.279 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Amazon S3 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.287 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Blob Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.292 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Data Lake Storage Gen1 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.297 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Dropbox Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.302 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Salesforce Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.307 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Google Cloud Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.312 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Twitter Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.313 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : RapidMiner Server repository at 'http://127.0.0.1:8080' is reachable. Refreshing repository content now.
2019-04-02 00:44:28.506 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Remote File Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.512 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Amazon S3 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.518 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Blob Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.524 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Data Lake Storage Gen1 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.530 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Dropbox Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.536 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Salesforce Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.542 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Google Cloud Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.547 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Twitter Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.622 INFO 4656 --- [main] c.r.e.r.r.remote.ProcessServiceFacade : Setting up ProcessService v1.0
2019-04-02 00:44:28.727 INFO 4656 --- [main] c.r.e.r.r.remote.ProcessServiceFacade : Setting up ProcessService v1.3
2019-04-02 00:44:28.806 INFO 4656 --- [main] c.r.e.j.execution.SimpleExecutor : Initialize process context
2019-04-02 00:44:28.811 INFO 4656 --- [main] com.rapidminer.Process : No filename given for result file, using stdout for logging results!
2019-04-02 00:44:28.817 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Execution of process started
2019-04-02 00:44:28.817 INFO 4656 --- [main] com.rapidminer.Process : Process //_LOCAL/home/admin/Rankings/processes/Test starts
2019-04-02 00:44:28.818 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Started operator 'Process (Process)'
2019-04-02 00:44:28.820 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Started operator 'Execute R (Execute R)'
2019-04-02 00:44:28.821 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Execution of process stopped
2019-04-02 00:44:28.824 ERROR 4656 --- [main] c.r.e.j.service.ErrorReporterService : User Error during execution
com.rapidminer.operator.UserError: Failed to detect Rscript at the given path.
at com.rapidminer.extension.rscripting.operator.scripting.r.RScriptingOperator.doWork(RScriptingOperator.java:74)
at com.rapidminer.operator.Operator.execute(Operator.java:1026)
at com.rapidminer.operator.execution.SimpleUnitExecutor.execute(SimpleUnitExecutor.java:77)
at com.rapidminer.operator.ExecutionUnit$2.run(ExecutionUnit.java:812)
at com.rapidminer.operator.ExecutionUnit$2.run(ExecutionUnit.java:807)
at java.security.AccessController.doPrivileged(Native Method)
at com.rapidminer.operator.ExecutionUnit.execute(ExecutionUnit.java:807)
at com.rapidminer.operator.OperatorChain.doWork(OperatorChain.java:423)
at com.rapidminer.operator.Operator.execute(Operator.java:1026)
at com.rapidminer.Process.executeRoot(Process.java:1386)
at com.rapidminer.Process.execute(Process.java:1327)
at com.rapidminer.Process.run(Process.java:1300)
at com.rapidminer.Process.run(Process.java:1186)
at com.rapidminer.Process.run(Process.java:1139)
at com.rapidminer.Process.run(Process.java:1134)
at com.rapidminer.Process.run(Process.java:1124)
at com.rapidminer.execution.jobcontainer.execution.SimpleExecutor.executeProcess(SimpleExecutor.java:90)
at com.rapidminer.execution.jobcontainer.EngineRunner.onApplicationEvent(EngineRunner.java:76)
at com.rapidminer.execution.jobcontainer.EngineRunner.onApplicationEvent(EngineRunner.java:30)
at org.springframework.context.event.SimpleApplicationEventMulticaster.doInvokeListener(SimpleApplicationEventMulticaster.java:172)
at org.springframework.context.event.SimpleApplicationEventMulticaster.invokeListener(SimpleApplicationEventMulticaster.java:165)
at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:139)
at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:393)
at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:347)
at org.springframework.boot.context.event.EventPublishingRunListener.finished(EventPublishingRunListener.java:101)
at org.springframework.boot.SpringApplicationRunListeners.callFinishedListener(SpringApplicationRunListeners.java:79)
at org.springframework.boot.SpringApplicationRunListeners.finished(SpringApplicationRunListeners.java:72)
at org.springframework.boot.SpringApplication.run(SpringApplication.java:305)
at org.springframework.boot.builder.SpringApplicationBuilder.run(SpringApplicationBuilder.java:134)
at com.rapidminer.execution.jobcontainer.Application.main(Application.java:47)
2019-04-02 00:44:28.826 INFO 4656 --- [main] c.r.execution.jobcontainer.EngineRunner : Execution finished with exit code 'USER_ERROR'
2019-04-02 00:44:28.826 INFO 4656 --- [main] c.r.e.j.service.ShutdownService : Job Container exits with exit code 'USER_ERROR'
2019-04-02 00:44:29.080 INFO 4656 --- [Thread-2] s.c.a.AnnotationConfigApplicationContext : Closing org.springframework.context.annotation.AnnotationConfigApplicationContext@7eac9008: startup date [Tue Apr 02 00:44:15 CEST 2019]; root of context hierarchy
2019-04-02 00:44:29.083 INFO 4656 --- [Thread-2] o.s.c.support.DefaultLifecycleProcessor : Stopping beans in phase 0
2019-04-02 00:44:29.084 INFO 4656 --- [Thread-2] o.s.j.e.a.AnnotationMBeanExporter : Unregistering JMX-exposed beans on shutdown
2019-04-02 00:44:29.084 INFO 4656 --- [Thread-2] o.s.s.c.ThreadPoolTaskScheduler : Shutting down ExecutorService 'taskScheduler'
\MARCIN\rapidminer-server\rapidminer-server-9.2.1\bin)
2019-04-02 00:44:15.241 INFO 4656 --- [main] c.r.execution.jobcontainer.Application : No active profile set, falling back to default profiles: default
2019-04-02 00:44:15.400 INFO 4656 --- [main] s.c.a.AnnotationConfigApplicationContext : Refreshing org.springframework.context.annotation.AnnotationConfigApplicationContext@7eac9008: startup date [Tue Apr 02 00:44:15 CEST 2019]; root of context hierarchy
2019-04-02 00:44:16.284 INFO 4656 --- [main] o.s.s.c.ThreadPoolTaskScheduler : Initializing ExecutorService 'taskScheduler'
2019-04-02 00:44:16.895 INFO 4656 --- [main] o.s.j.e.a.AnnotationMBeanExporter : Registering beans for JMX exposure on startup
2019-04-02 00:44:16.901 INFO 4656 --- [main] o.s.c.support.DefaultLifecycleProcessor : Starting beans in phase 0
2019-04-02 00:44:16.943 INFO 4656 --- [taskScheduler-2] c.r.e.j.service.RemoteRepositoryService : Trying to update JWT token from auth properties.
2019-04-02 00:44:16.944 INFO 4656 --- [taskScheduler-2] c.r.e.j.service.RemoteRepositoryService : Updated JWT token from auth properties file.
2019-04-02 00:44:16.943 INFO 4656 --- [taskScheduler-1] c.r.e.j.service.OutOfMemoryWatchdog : Current memory usage is 544MB / 4064MB
2019-04-02 00:44:16.949 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Changing 'user.home' system property to 'D:\Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\data\jobs\21b3e330-6cf4-4eee-9d71-54cc0604de0b'
2019-04-02 00:44:16.949 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Generating new in-memory cipher key
2019-04-02 00:44:17.063 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Setting pre-defined RapidMiner properties from 'D:\Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\data\jobs\21b3e330-6cf4-4eee-9d71-54cc0604de0b\rapidminer.properties'
2019-04-02 00:44:17.216 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Initializing the RapidMiner Core
2019-04-02 00:44:17.216 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Setting execution mode to 'JOB_CONTAINER'
2019-04-02 00:44:17.228 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Loading bundled extension from 'D:\MARCIN\rapidminer-server\rapidminer-server-9.2.1\job-agent\bin\..\lib\container\plugins'
2019-04-02 00:44:17.228 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : Loading custom extensions from 'D:\Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions'
2019-04-02 00:44:17.329 INFO 4656 --- [main] com.rapidminer : Set locale to en.
2019-04-02 00:44:17.357 INFO 4656 --- [main] PlatformUtilities : rapidminer.home is 'D:\MARCIN\rapidminer-server\rapidminer-server-9.2.1\job-agent\bin\..\lib\container'.
2019-04-02 00:44:17.365 INFO 4656 --- [main] com.rapidminer : Initializing license manager.
2019-04-02 00:44:17.409 INFO 4656 --- [main] com.rapidminer : Cannot access file system in execution mode JOB_CONTAINER. Not loading repositories.
2019-04-02 00:44:17.819 INFO 4656 --- [main] com.rapidminer : Register plugin: Advanced File Connectors
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Blending
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Browser
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Cloud Connectivity
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Concurrency
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: H2O
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: HTML5 Charts
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: JDBC Connectors
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Legacy Result Access
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Model Simulator
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: PMML
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Process Scheduling
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Productivity
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Professional
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Remote Repository
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Social Media
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Time Series
2019-04-02 00:44:17.820 INFO 4656 --- [main] com.rapidminer : Register plugin: Utility
2019-04-02 00:44:17.829 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Statistics Extension in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_stat-2.2.543.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_stat-2.1.692.jar. Keeping extension with version 2.2.543.
2019-04-02 00:44:17.846 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Text Processing in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_text-8.1.0.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_text-7.4.1.jar. Keeping extension with version 8.1.0.
2019-04-02 00:44:17.864 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Jackhammer Extension in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_toolkit-2.2.572.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_toolkit-2.2.430.jar. Keeping extension with version 2.2.572.
2019-04-02 00:44:17.943 WARN 4656 --- [main] com.rapidminer : Duplicate extension definition for extension Web Mining in \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_web-9.0.0.jar and \Marcin\rapidminer-server\rapidminer-server-home\job-agent-home\resources\extensions\rmx_web-7.3.0.jar. Keeping extension with version 9.0.0.
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Advanced Reporting Extension
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: recommenders
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Keras
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Reporting
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: R Scripting
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Value Series
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Statistics Extension
2019-04-02 00:44:17.944 INFO 4656 --- [main] com.rapidminer : Register plugin: Text Processing
2019-04-02 00:44:17.945 INFO 4656 --- [main] com.rapidminer : Register plugin: Jackhammer Extension
2019-04-02 00:44:17.945 INFO 4656 --- [main] com.rapidminer : Register plugin: Web Mining
2019-04-02 00:44:18.685 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: Using Server-FallBack for License Key...
2019-04-02 00:44:18.685 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: No License Key found!
2019-04-02 00:44:18.685 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: Using Server-FallBack for Licensee...
2019-04-02 00:44:18.685 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_toolkit: No Licensee Email found!
2019-04-02 00:44:18.737 INFO 4656 --- [main] com.rapidminer : Registered configurator Remote File Connection.
2019-04-02 00:44:19.057 INFO 4656 --- [main] com.rapidminer : Registered configurator Twitter Connection.
2019-04-02 00:44:19.068 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: Using Server-FallBack for License Key...
2019-04-02 00:44:19.068 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: No License Key found!
2019-04-02 00:44:19.068 INFO 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: Using Server-FallBack for Licensee...
2019-04-02 00:44:19.068 WARN 4656 --- [main] com.owc.license.LicenseManager : rmx_statistics: No Licensee Email found!
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Salesforce Connection.
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Amazon S3 Connection.
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Azure Blob Storage Connection.
2019-04-02 00:44:20.095 INFO 4656 --- [main] com.rapidminer : Registered configurator Azure Data Lake Storage Gen1 Connection.
2019-04-02 00:44:20.096 INFO 4656 --- [main] com.rapidminer : Registered configurator Google Cloud Storage Connection.
2019-04-02 00:44:20.096 INFO 4656 --- [main] com.rapidminer : Registered configurator Dropbox Connection.
2019-04-02 00:44:20.910 WARN 4656 --- [main] com.rapidminer : Missing database driver class name for ODBC Bridge (e.g. Access)
2019-04-02 00:44:20.911 WARN 4656 --- [main] com.rapidminer : Missing database driver class name for Ingres
2019-04-02 00:44:21.491 INFO 4656 --- [main] com.rapidminer : Registered 'Time Series' as sample folder.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Reporting was loaded in 4ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension PMML was loaded in 4ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Value Series was loaded in 6ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Keras was loaded in 8ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Advanced Reporting Extension was loaded in 18ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Statistics Extension was loaded in 25ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension recommenders was loaded in 35ms.
2019-04-02 00:44:21.665 INFO 4656 --- [main] com.rapidminer : Extension Text Processing was loaded in 39ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Process Scheduling was loaded in 88ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Social Media was loaded in 93ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Professional was loaded in 93ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Blending was loaded in 100ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Advanced File Connectors was loaded in 103ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Productivity was loaded in 105ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Jackhammer Extension was loaded in 105ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Concurrency was loaded in 109ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Remote Repository was loaded in 109ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Legacy Result Access was loaded in 109ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Utility was loaded in 122ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension Browser was loaded in 123ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension R Scripting was loaded in 137ms.
2019-04-02 00:44:21.666 INFO 4656 --- [main] com.rapidminer : Extension HTML5 Charts was loaded in 142ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Model Simulator was loaded in 148ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Time Series was loaded in 167ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension JDBC Connectors was loaded in 205ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Cloud Connectivity was loaded in 445ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension H2O was loaded in 479ms.
2019-04-02 00:44:21.667 INFO 4656 --- [main] com.rapidminer : Extension Web Mining was loaded in 594ms.
2019-04-02 00:44:21.947 INFO 4656 --- [taskScheduler-2] c.r.e.j.service.OutOfMemoryWatchdog : Current memory usage is 1696MB / 4064MB
2019-04-02 00:44:26.967 INFO 4656 --- [taskScheduler-1] c.r.e.j.service.OutOfMemoryWatchdog : Current memory usage is 3328MB / 4064MB
2019-04-02 00:44:28.136 INFO 4656 --- [main] com.rapidminer : Cannot access file system in execution mode JOB_CONTAINER. Not loading repositories.
2019-04-02 00:44:28.140 INFO 4656 --- [main] com.rapidminer : Load configuration for Remote File Connection.
2019-04-02 00:44:28.140 INFO 4656 --- [main] com.rapidminer : No configuration file found for Remote File Connection
2019-04-02 00:44:28.141 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Remote File Connection.
2019-04-02 00:44:28.141 INFO 4656 --- [main] com.rapidminer : Load configuration for Amazon S3 Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : No configuration file found for Amazon S3 Connection
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Amazon S3 Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Load configuration for Azure Blob Storage Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : No configuration file found for Azure Blob Storage Connection
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Azure Blob Storage Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : Load configuration for Azure Data Lake Storage Gen1 Connection.
2019-04-02 00:44:28.142 INFO 4656 --- [main] com.rapidminer : No configuration file found for Azure Data Lake Storage Gen1 Connection
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Azure Data Lake Storage Gen1 Connection.
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Load configuration for Dropbox Connection.
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : No configuration file found for Dropbox Connection
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Dropbox Connection.
2019-04-02 00:44:28.143 INFO 4656 --- [main] com.rapidminer : Load configuration for Salesforce Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : No configuration file found for Salesforce Connection
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Salesforce Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Load configuration for Google Cloud Storage Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : No configuration file found for Google Cloud Storage Connection
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Google Cloud Storage Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Load configuration for Twitter Connection.
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : No configuration file found for Twitter Connection
2019-04-02 00:44:28.144 INFO 4656 --- [main] com.rapidminer : Loaded configurations for 0 objects of type Twitter Connection.
2019-04-02 00:44:28.145 INFO 4656 --- [main] c.r.e.core.RapidMinerInitializer : License framework initialized. Current active license edition is 'non-commercial'. The license expires on '2020-01-24'.
2019-04-02 00:44:28.145 INFO 4656 --- [main] c.r.execution.jobcontainer.EngineRunner : Starting execution of process with job ID '21b3e330-6cf4-4eee-9d71-54cc0604de0b' for user 'admin'.
2019-04-02 00:44:28.146 INFO 4656 --- [main] c.r.e.j.service.RepositoryService : Executed process is stored in '/home/admin/Rankings/processes/Test'.
2019-04-02 00:44:28.147 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : Trying to update JWT token from auth properties.
2019-04-02 00:44:28.147 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : Skipped updating the JWT token as old one equals the new one.
2019-04-02 00:44:28.147 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : Initializing the connection to RapidMiner Server. Using protocol 'http', host '127.0.0.1', and port '8080'
2019-04-02 00:44:28.174 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Remote File Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.180 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Amazon S3 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.185 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Blob Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.190 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Data Lake Storage Gen1 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.195 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Dropbox Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.201 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Salesforce Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.205 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Google Cloud Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.211 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Twitter Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.273 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Remote File Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.279 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Amazon S3 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.287 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Blob Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.292 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Data Lake Storage Gen1 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.297 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Dropbox Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.302 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Salesforce Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.307 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Google Cloud Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.312 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Twitter Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.313 INFO 4656 --- [main] c.r.e.j.service.RemoteRepositoryService : RapidMiner Server repository at 'http://127.0.0.1:8080' is reachable. Refreshing repository content now.
2019-04-02 00:44:28.506 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Remote File Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.512 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Amazon S3 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.518 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Blob Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.524 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Azure Data Lake Storage Gen1 Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.530 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Dropbox Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.536 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Salesforce Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.542 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Google Cloud Storage Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.547 INFO 4656 --- [main] com.rapidminer : Loading 0 configurations of type Twitter Connection from RapidMiner Server _LOCAL
2019-04-02 00:44:28.622 INFO 4656 --- [main] c.r.e.r.r.remote.ProcessServiceFacade : Setting up ProcessService v1.0
2019-04-02 00:44:28.727 INFO 4656 --- [main] c.r.e.r.r.remote.ProcessServiceFacade : Setting up ProcessService v1.3
2019-04-02 00:44:28.806 INFO 4656 --- [main] c.r.e.j.execution.SimpleExecutor : Initialize process context
2019-04-02 00:44:28.811 INFO 4656 --- [main] com.rapidminer.Process : No filename given for result file, using stdout for logging results!
2019-04-02 00:44:28.817 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Execution of process started
2019-04-02 00:44:28.817 INFO 4656 --- [main] com.rapidminer.Process : Process //_LOCAL/home/admin/Rankings/processes/Test starts
2019-04-02 00:44:28.818 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Started operator 'Process (Process)'
2019-04-02 00:44:28.820 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Started operator 'Execute R (Execute R)'
2019-04-02 00:44:28.821 INFO 4656 --- [main] c.r.e.j.e.ExecutionProcessListener : Execution of process stopped
2019-04-02 00:44:28.824 ERROR 4656 --- [main] c.r.e.j.service.ErrorReporterService : User Error during execution
com.rapidminer.operator.UserError: Failed to detect Rscript at the given path.
at com.rapidminer.extension.rscripting.operator.scripting.r.RScriptingOperator.doWork(RScriptingOperator.java:74)
at com.rapidminer.operator.Operator.execute(Operator.java:1026)
at com.rapidminer.operator.execution.SimpleUnitExecutor.execute(SimpleUnitExecutor.java:77)
at com.rapidminer.operator.ExecutionUnit$2.run(ExecutionUnit.java:812)
at com.rapidminer.operator.ExecutionUnit$2.run(ExecutionUnit.java:807)
at java.security.AccessController.doPrivileged(Native Method)
at com.rapidminer.operator.ExecutionUnit.execute(ExecutionUnit.java:807)
at com.rapidminer.operator.OperatorChain.doWork(OperatorChain.java:423)
at com.rapidminer.operator.Operator.execute(Operator.java:1026)
at com.rapidminer.Process.executeRoot(Process.java:1386)
at com.rapidminer.Process.execute(Process.java:1327)
at com.rapidminer.Process.run(Process.java:1300)
at com.rapidminer.Process.run(Process.java:1186)
at com.rapidminer.Process.run(Process.java:1139)
at com.rapidminer.Process.run(Process.java:1134)
at com.rapidminer.Process.run(Process.java:1124)
at com.rapidminer.execution.jobcontainer.execution.SimpleExecutor.executeProcess(SimpleExecutor.java:90)
at com.rapidminer.execution.jobcontainer.EngineRunner.onApplicationEvent(EngineRunner.java:76)
at com.rapidminer.execution.jobcontainer.EngineRunner.onApplicationEvent(EngineRunner.java:30)
at org.springframework.context.event.SimpleApplicationEventMulticaster.doInvokeListener(SimpleApplicationEventMulticaster.java:172)
at org.springframework.context.event.SimpleApplicationEventMulticaster.invokeListener(SimpleApplicationEventMulticaster.java:165)
at org.springframework.context.event.SimpleApplicationEventMulticaster.multicastEvent(SimpleApplicationEventMulticaster.java:139)
at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:393)
at org.springframework.context.support.AbstractApplicationContext.publishEvent(AbstractApplicationContext.java:347)
at org.springframework.boot.context.event.EventPublishingRunListener.finished(EventPublishingRunListener.java:101)
at org.springframework.boot.SpringApplicationRunListeners.callFinishedListener(SpringApplicationRunListeners.java:79)
at org.springframework.boot.SpringApplicationRunListeners.finished(SpringApplicationRunListeners.java:72)
at org.springframework.boot.SpringApplication.run(SpringApplication.java:305)
at org.springframework.boot.builder.SpringApplicationBuilder.run(SpringApplicationBuilder.java:134)
at com.rapidminer.execution.jobcontainer.Application.main(Application.java:47)
2019-04-02 00:44:28.826 INFO 4656 --- [main] c.r.execution.jobcontainer.EngineRunner : Execution finished with exit code 'USER_ERROR'
2019-04-02 00:44:28.826 INFO 4656 --- [main] c.r.e.j.service.ShutdownService : Job Container exits with exit code 'USER_ERROR'
2019-04-02 00:44:29.080 INFO 4656 --- [Thread-2] s.c.a.AnnotationConfigApplicationContext : Closing org.springframework.context.annotation.AnnotationConfigApplicationContext@7eac9008: startup date [Tue Apr 02 00:44:15 CEST 2019]; root of context hierarchy
2019-04-02 00:44:29.083 INFO 4656 --- [Thread-2] o.s.c.support.DefaultLifecycleProcessor : Stopping beans in phase 0
2019-04-02 00:44:29.084 INFO 4656 --- [Thread-2] o.s.j.e.a.AnnotationMBeanExporter : Unregistering JMX-exposed beans on shutdown
2019-04-02 00:44:29.084 INFO 4656 --- [Thread-2] o.s.s.c.ThreadPoolTaskScheduler : Shutting down ExecutorService 'taskScheduler'Find more posts tagged with
Sort by:
1 - 2 of
21
Dear @Pavithra_Rao,
thank you for your response. It works now.
It is job agent that's responsible for executing the Rscript.exe. It is not using the system property rapidminer.r_scripting.path entered in the Web Gui of the Rapid Miner Server, but the entry in the file you specified.
Thank you for this hint, I think that the documentation should be
updated, as there was no information about the additional configuration
file that could be responsible for the execution of the Rscript (and, I
suppose, python executable, as well?).
After entering
rapidminer.r_scripting.path = C:\\Program Files\\R\\R-3.5.1\\bin\\Rscript.exe into the rapidminer.properties file, job agent successfully executed the Rscript.exe I deleted the rapidminer.r_scripting.path from the System Settings and everything still works fine.
But there was another problem...
I was surprised by the new error: data.table package was not found (but I have installed it!). As I mentioned in my previous entry, RM Studio was correctly executing Rscript. However, RM Server was still not able to correctly run Rscript.
I checked, if the executions of Rscript by RM Studio and RM Server were exactly the same (in Windows Event Viewer). You can find how to turn on logging of the executed programs here:
https://superuser.com/a/603488RScript started by RM Studio was executed by the currently logged user and therefore R was able to access the R local library.
Rscript started by RM Server (running as a service) was executed by some default (or system) user and therefore R was using this user's local library - with no "data.table" package installed.
I added to the etc/Rprofile.site the following lines to set up default "global" library path:
.First <- function(){<br> .libPaths("D:/myfolder/r-libs")<br>}Now, all the R packages are installed in this location and Rscript executed by RM Server is able to acces them.
One more time thank you for your help.
Best regards
Maciek
Sort by:
1 - 1 of
11
- Have you made sure to add the path to job-agent >> rapidminer.properties file as well?(..\<job-agent-home>\rapidminer-jobagent\home\config\rapidminer\rapidminer.properties)Just like adding rapidminer.r_scripting.path to Server Web UI >> Administration >>Settings, please make sure to add it to job-agent rapidminer.properties file. This job-agent is the one attached to the queue that you are trying to run the Execute R script process on.
- Since it's a windows machine make sure the path has double \\ as shown below; in both the entry locations rapidminer.r_scripting.path = C:\\Program Files\\R\\R-3.5.1\\bin\\Rscript.exe
maciej_pankiewi ,
Cheers,
Pavithra
Cheers,
Pavithra
- Have you made sure to add the path to job-agent >> rapidminer.properties file as well?(..\<job-agent-home>\rapidminer-jobagent\home\config\rapidminer\rapidminer.properties)Just like adding rapidminer.r_scripting.path to Server Web UI >> Administration >>Settings, please make sure to add it to job-agent rapidminer.properties file. This job-agent is the one attached to the queue that you are trying to run the Execute R script process on.
- Since it's a windows machine make sure the path has double \\ as shown below; in both the entry locations rapidminer.r_scripting.path = C:\\Program Files\\R\\R-3.5.1\\bin\\Rscript.exe
Hope this helps.Cheers,
Pavithra