eclipse-che / che

Kubernetes based Cloud Development Environments for Enterprise Teams
http://eclipse.org/che
Eclipse Public License 2.0
6.99k stars 1.19k forks source link

Failed to run the workspace: "Installation 'org.eclipse.che.exec' failed, script exit code is 127" #12677

Closed mmeliani closed 5 years ago

mmeliani commented 5 years ago

Description

I started che chart using che-server:latest ( same for nightly ) with tls enabled and self signed certificate, initially che-server pod doesn't come up and got error :

Caused by: java.lang.RuntimeException: Exception while retrieving OpenId configuration from endpoint: https://keycloak.shared.devlab.test.vlab.com/auth/realms/che/.well-known/openid-configuration

i managed to solve that by creating a generic secret that wrap ca.crt and add appropriate env variable CHE_SELFSIGNEDCERT in the deployments and che-server pod started correctly, but i got antoher error while creating the workspace and it's probably related to certs also, So what about the secret i'm using for ingress ? should che be aware of it also ? where am I going wrong ?

Diagnostics

Exec Agent binary is downloaded remotely

Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading

gzip: stdin: unexpected end of file

/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found

tar: Child returned status 1

tar: Error is not recoverable: exiting now

Error: Failed to run the workspace: "Installation 'org.eclipse.che.exec' failed, script exit code is 127"
sleshchenko commented 5 years ago

cc @eivantsov

mmeliani commented 5 years ago

logs from che pod :

Bootstrapping RuntimeIdentityImpl{workspaceId='workspacenlnwwi6d474ihust', envName='default', ownerId='47f31d28-d997-4354-9584-0dab05f6cb59'}:dev-machine. Creating folder for bootstrapper
2019-02-18 10:05:35,558[ineSharedPool-0]  [DEBUG] [w.i.k.b.KubernetesBootstrapper 167]  - Bootstrapping RuntimeIdentityImpl{workspaceId='workspacenlnwwi6d474ihust', envName='default', ownerId='47f31d28-d997-4354-9584-0dab05f6cb59'}:dev-machine. Downloading bootstrapper binary
2019-02-18 10:05:37,629[ineSharedPool-0]  [DEBUG] [w.i.k.b.KubernetesBootstrapper 187]  - Bootstrapping RuntimeIdentityImpl{workspaceId='workspacenlnwwi6d474ihust', envName='default', ownerId='47f31d28-d997-4354-9584-0dab05f6cb59'}:dev-machine. Creating config file
2019-02-18 10:05:39,239[ineSharedPool-0]  [DEBUG] [w.i.k.b.KubernetesBootstrapper 113]  - Bootstrapping RuntimeIdentityImpl{workspaceId='workspacenlnwwi6d474ihust', envName='default', ownerId='47f31d28-d997-4354-9584-0dab05f6cb59'}:dev-machine. Launching bootstrapper process
2019-02-18 10:05:39,570[uestProcessor-8]  [ERROR] [l.ErrorInstallerLogEventLogger 43]   - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacenlnwwi6d474ihust` text=`mkdir: cannot create directory ‘/home/user/che’: Permission denied` time=`2019-02-18T10:05:39.565857146Z`
2019-02-18 10:05:40,339[uestProcessor-7]  [ERROR] [l.ErrorInstallerLogEventLogger 43]   - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacenlnwwi6d474ihust` text=`tar: Child returned status 1` time=`2019-02-18T10:05:40.336409355Z`
2019-02-18 10:05:40,349[estProcessor-10]  [ERROR] [l.ErrorInstallerLogEventLogger 43]   - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacenlnwwi6d474ihust` text=`/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found` time=`2019-02-18T10:05:40.336821017Z`
2019-02-18 10:05:40,349[uestProcessor-8]  [ERROR] [l.ErrorInstallerLogEventLogger 43]   - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacenlnwwi6d474ihust` text=`gzip: stdin: unexpected end of file` time=`2019-02-18T10:05:40.336104079Z`
2019-02-18 10:05:40,350[uestProcessor-9]  [ERROR] [l.ErrorInstallerLogEventLogger 43]   - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacenlnwwi6d474ihust` text=`tar: Error is not recoverable: exiting now` time=`2019-02-18T10:05:40.336427731Z`
2019-02-18 10:05:40,351[aceSharedPool-5]  [WARN ] [.i.k.KubernetesInternalRuntime 249]  - Failed to start Kubernetes runtime of workspace workspacenlnwwi6d474ihust. Cause: Installation 'org.eclipse.che.exec' failed, script exit code is 127
2019-02-18 10:05:40,656[aceSharedPool-5]  [INFO ] [o.e.c.a.w.s.WorkspaceRuntimes 417]   - Workspace 'user:wksp-f2cd' with id 'workspacenlnwwi6d474ihust' start failed
mmeliani commented 5 years ago

tls:

this is the secret i'm using for che ingress endpoint , and i'm only giving ca.crt in the CHE_SELFSIGNEDCERT , should the workspace pod be aware of those tls certs in the secret name or not ? @sleshchenko i saw ur commit about this en entrypoint, how can i do this ?

sleshchenko commented 5 years ago

@mmeliani Che Server automatically creates the cert secret for workspace pods if CHE_SELF__SIGNED__CERT is set. See https://github.com/eclipse/che/blob/master/infrastructures/kubernetes/src/main/java/org/eclipse/che/workspace/infrastructure/kubernetes/provision/CertificateProvisioner.java And in logs you shared I can see that cert file is bound

Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading

It's needed to find a way to download exec-agent binaries from workspace container manually and check what's wrong with binaries/CheServer-WorkspacePod connection even after certificates using.

An idea that I have - you can modify installers script and silent option for curl command. Will try and provide you detailed instructions.

sleshchenko commented 5 years ago

@mmeliani I've created a PR where I added -f and -S options for curl. It can help to understand what happened during curl command execution in your case. Not to wait my PR merged, you are able to do the same updates on your Che installation, you can use swagger to update installers scripts quite easly(It's available on by the following URL ${CHE_HOST}/swagger/). Not that your changes will be overridden after Che Server restart. The first exception in your case occured in org.eclipse.che.exec, so you can update only this installer.

mmeliani commented 5 years ago

@sleshchenko did not understand how to update installers scripts using the api? how that possible ? could u please show an example how to update it ?

sleshchenko commented 5 years ago

@mmeliani

  1. Go to {YOUR_CHE_HOST}/swagger/#!/installer/getInstaller
  2. Get org.eclipse.che.exec key for getting exec installer JSON.
  3. Replace curl -s with curl -sSf
  4. Go to {YOUR_CHE_HOST}/swagger/#!/installer/update and use updated JSON as request body.
  5. Check that response is 204. Now your exec installer should be updated and more details should be available.
mmeliani commented 5 years ago
Che Server Logs with DEBUG level ``` 2019-02-19 15:13:16,956[uestProcessor-7] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading","time":"2019-02-19T15:13:16.944674998Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDOUT","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:16,957[uestProcessor-7] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading","time":"2019-02-19T15:13:16.944674998Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDOUT","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,307[8080-Acceptor-0] [DEBUG] [o.a.t.util.threads.LimitLatch 115] - Counting up[http-nio-8080-Acceptor-0] latch=2 2019-02-19 15:13:17,308[nio-8080-exec-4] [DEBUG] [o.a.c.http11.Http11NioProtocol 712] - Processing socket [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60522]] with status [OPEN_READ] 2019-02-19 15:13:17,308[nio-8080-exec-4] [DEBUG] [o.a.c.http11.Http11NioProtocol 724] - Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60522]] 2019-02-19 15:13:17,308[nio-8080-exec-4] [DEBUG] [o.a.c.http11.Http11NioProtocol 789] - Popped processor [org.apache.coyote.http11.Http11Processor@519c0918] from cache 2019-02-19 15:13:17,308[nio-8080-exec-4] [DEBUG] [o.a.t.u.net.SocketWrapperBase 312] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@d7b53a5:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60522]], Read from buffer: [0] 2019-02-19 15:13:17,308[nio-8080-exec-4] [DEBUG] [o.a.t.util.net.NioEndpoint 1225] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@d7b53a5:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60522]], Read direct from socket: [481] 2019-02-19 15:13:17,308[nio-8080-exec-4] [DEBUG] [o.a.c.http11.Http11InputBuffer 402] - Received [HEAD /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz HTTP/1.1 Host: che-che.che.shared.domainname Connection: close X-Real-IP: 127.0.0.1 X-Forwarded-For: 127.0.0.1 X-Forwarded-Host: che-che.che.shared.domainname X-Forwarded-Port: 443 X-Forwarded-Proto: https X-Original-URI: /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz X-Scheme: https User-Agent: curl/7.47.0 Accept: */* ] 2019-02-19 15:13:17,309[nio-8080-exec-4] [DEBUG] [o.a.c.valves.RemoteIpValve 661] - Incoming request /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz with originalRemoteAddr '172.16.1.14', originalRemoteHost='172.16.1.14', originalSecure='false', originalScheme='http' will be seen as newRemoteAddr='127.0.0.1', newRemoteHost='127.0.0.1', newScheme='https', newSecure='true' 2019-02-19 15:13:17,309[nio-8080-exec-4] [DEBUG] [o.a.c.a.AuthenticatorBase 455] - Security checking request HEAD /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,309[nio-8080-exec-4] [DEBUG] [o.a.catalina.realm.RealmBase 547] - No applicable constraints defined 2019-02-19 15:13:17,309[nio-8080-exec-4] [DEBUG] [o.a.c.a.AuthenticatorBase 491] - Not subject to any constraint 2019-02-19 15:13:17,309[nio-8080-exec-4] [DEBUG] [o.a.t.util.http.Parameters 117] - Set encoding to ISO-8859-1 2019-02-19 15:13:17,310[nio-8080-exec-4] [DEBUG] [o.a.c.http11.Http11Processor 74] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@d7b53a5:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60522]], Status in: [OPEN_READ], State out: [CLOSED] 2019-02-19 15:13:17,310[nio-8080-exec-4] [DEBUG] [o.a.c.http11.Http11NioProtocol 996] - Pushed Processor [org.apache.coyote.http11.Http11Processor@519c0918] 2019-02-19 15:13:17,310[nio-8080-exec-4] [DEBUG] [o.a.t.util.threads.LimitLatch 128] - Counting down[http-nio-8080-exec-4] latch=2 2019-02-19 15:13:17,310[nio-8080-exec-4] [DEBUG] [o.a.t.util.net.NioEndpoint 554] - Socket: [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[closed]] closed 2019-02-19 15:13:17,375[8080-Acceptor-0] [DEBUG] [o.a.t.util.threads.LimitLatch 115] - Counting up[http-nio-8080-Acceptor-0] latch=2 2019-02-19 15:13:17,375[nio-8080-exec-8] [DEBUG] [o.a.c.http11.Http11NioProtocol 712] - Processing socket [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.19:59438]] with status [OPEN_READ] 2019-02-19 15:13:17,375[nio-8080-exec-8] [DEBUG] [o.a.c.http11.Http11NioProtocol 724] - Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.19:59438]] 2019-02-19 15:13:17,375[nio-8080-exec-8] [DEBUG] [o.a.c.http11.Http11NioProtocol 789] - Popped processor [org.apache.coyote.http11.Http11Processor@519c0918] from cache 2019-02-19 15:13:17,375[nio-8080-exec-8] [DEBUG] [o.a.t.u.net.SocketWrapperBase 312] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@31dd296b:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.19:59438]], Read from buffer: [0] 2019-02-19 15:13:17,375[nio-8080-exec-8] [DEBUG] [o.a.t.util.net.NioEndpoint 1225] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@31dd296b:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.19:59438]], Read direct from socket: [131] 2019-02-19 15:13:17,376[nio-8080-exec-8] [DEBUG] [o.a.c.http11.Http11InputBuffer 402] - Received [GET /api/system/state HTTP/1.1 Host: 192.168.35.34:8080 User-Agent: kube-probe/1.12 Accept-Encoding: gzip Connection: close ] 2019-02-19 15:13:17,376[nio-8080-exec-8] [DEBUG] [o.a.c.valves.RemoteIpValve 661] - Incoming request /api/system/state with originalRemoteAddr '172.16.1.19', originalRemoteHost='172.16.1.19', originalSecure='false', originalScheme='http' will be seen as newRemoteAddr='172.16.1.19', newRemoteHost='172.16.1.19', newScheme='http', newSecure='false' 2019-02-19 15:13:17,376[nio-8080-exec-8] [DEBUG] [o.a.c.a.AuthenticatorBase 455] - Security checking request GET /api/system/state 2019-02-19 15:13:17,376[nio-8080-exec-8] [DEBUG] [o.a.catalina.realm.RealmBase 547] - No applicable constraints defined 2019-02-19 15:13:17,376[nio-8080-exec-8] [DEBUG] [o.a.c.a.AuthenticatorBase 491] - Not subject to any constraint 2019-02-19 15:13:17,377[nio-8080-exec-8] [DEBUG] [o.a.t.util.http.Parameters 117] - Set encoding to ISO-8859-1 2019-02-19 15:13:17,377[nio-8080-exec-8] [DEBUG] [o.a.c.http11.Http11Processor 74] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@31dd296b:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.19:59438]], Status in: [OPEN_READ], State out: [CLOSED] 2019-02-19 15:13:17,377[nio-8080-exec-8] [DEBUG] [o.a.c.http11.Http11NioProtocol 996] - Pushed Processor [org.apache.coyote.http11.Http11Processor@519c0918] 2019-02-19 15:13:17,377[nio-8080-exec-8] [DEBUG] [o.a.t.util.threads.LimitLatch 128] - Counting down[http-nio-8080-exec-8] latch=2 2019-02-19 15:13:17,377[nio-8080-exec-8] [DEBUG] [o.a.t.util.net.NioEndpoint 554] - Socket: [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[closed]] closed 2019-02-19 15:13:17,682[8080-Acceptor-0] [DEBUG] [o.a.t.util.threads.LimitLatch 115] - Counting up[http-nio-8080-Acceptor-0] latch=2 2019-02-19 15:13:17,682[nio-8080-exec-2] [DEBUG] [o.a.c.http11.Http11NioProtocol 712] - Processing socket [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60528]] with status [OPEN_READ] 2019-02-19 15:13:17,682[nio-8080-exec-2] [DEBUG] [o.a.c.http11.Http11NioProtocol 724] - Found processor [null] for socket [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60528]] 2019-02-19 15:13:17,682[nio-8080-exec-2] [DEBUG] [o.a.c.http11.Http11NioProtocol 789] - Popped processor [org.apache.coyote.http11.Http11Processor@519c0918] from cache 2019-02-19 15:13:17,682[nio-8080-exec-2] [DEBUG] [o.a.t.u.net.SocketWrapperBase 312] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4da0154:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60528]], Read from buffer: [0] 2019-02-19 15:13:17,683[nio-8080-exec-2] [DEBUG] [o.a.t.util.net.NioEndpoint 1225] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4da0154:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60528]], Read direct from socket: [480] 2019-02-19 15:13:17,683[nio-8080-exec-2] [DEBUG] [o.a.c.http11.Http11InputBuffer 402] - Received [GET /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz HTTP/1.1 Host: che-che.che.shared.domainname Connection: close X-Real-IP: 127.0.0.1 X-Forwarded-For: 127.0.0.1 X-Forwarded-Host: che-che.che.shared.domainname X-Forwarded-Port: 443 X-Forwarded-Proto: https X-Original-URI: /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz X-Scheme: https User-Agent: curl/7.47.0 Accept: */* ] 2019-02-19 15:13:17,683[nio-8080-exec-2] [DEBUG] [o.a.c.valves.RemoteIpValve 661] - Incoming request /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz with originalRemoteAddr '172.16.1.14', originalRemoteHost='172.16.1.14', originalSecure='false', originalScheme='http' will be seen as newRemoteAddr='127.0.0.1', newRemoteHost='127.0.0.1', newScheme='https', newSecure='true' 2019-02-19 15:13:17,683[nio-8080-exec-2] [DEBUG] [o.a.c.a.AuthenticatorBase 455] - Security checking request GET /agent-binaries/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,683[nio-8080-exec-2] [DEBUG] [o.a.catalina.realm.RealmBase 547] - No applicable constraints defined 2019-02-19 15:13:17,683[nio-8080-exec-2] [DEBUG] [o.a.c.a.AuthenticatorBase 491] - Not subject to any constraint 2019-02-19 15:13:17,684[nio-8080-exec-2] [DEBUG] [o.a.t.util.http.Parameters 117] - Set encoding to ISO-8859-1 2019-02-19 15:13:17,684[nio-8080-exec-2] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,685[nio-8080-exec-2] [DEBUG] [o.a.c.http11.Http11Processor 74] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@4da0154:org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60528]], Status in: [OPEN_READ], State out: [SENDFILE] 2019-02-19 15:13:17,686[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,686[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,687[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,688[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,690[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,691[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,691[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,692[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,693[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,695[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,695[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,696[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,698[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,698[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,699[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,700[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 996] - OP_WRITE for sendfile: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,701[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 956] - Send file complete for: /home/user/eclipse-che/lib/linux_amd64/exec/exec-agent-linux_amd64.tar.gz 2019-02-19 15:13:17,702[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 970] - Send file connection is being closed 2019-02-19 15:13:17,702[-ClientPoller-1] [DEBUG] [o.a.c.http11.Http11NioProtocol 996] - Pushed Processor [org.apache.coyote.http11.Http11Processor@519c0918] 2019-02-19 15:13:17,702[-ClientPoller-1] [DEBUG] [o.a.t.util.threads.LimitLatch 128] - Counting down[http-nio-8080-ClientPoller-1] latch=2 2019-02-19 15:13:17,703[-ClientPoller-1] [DEBUG] [o.a.t.util.net.NioEndpoint 554] - Socket: [org.apache.tomcat.util.net.NioChannel@3f079cf0:java.nio.channels.SocketChannel[closed]] closed 2019-02-19 15:13:17,713[nio-8080-exec-6] [DEBUG] [o.a.c.http11.Http11NioProtocol 712] - Processing socket [org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]] with status [OPEN_READ] 2019-02-19 15:13:17,713[nio-8080-exec-6] [DEBUG] [o.a.c.http11.Http11NioProtocol 724] - Found processor [org.apache.coyote.http11.upgrade.UpgradeProcessorInternal@1398b130] for socket [org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]] 2019-02-19 15:13:17,713[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 59] - wsFrameServer.onDataAvailable 2019-02-19 15:13:17,713[nio-8080-exec-6] [DEBUG] [o.a.t.u.net.SocketWrapperBase 312] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@77fe3815:org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]], Read from buffer: [0] 2019-02-19 15:13:17,713[nio-8080-exec-6] [DEBUG] [o.a.t.util.net.NioEndpoint 1225] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@77fe3815:org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]], Read direct from socket: [1764] 2019-02-19 15:13:17,713[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 80] - Read [1764] bytes into input buffer ready for processing 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712260179Z","text":"curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712260179Z","text":"curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz","installer":"org.eclipse.che.exec","stream":"STDERR"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712260179Z","text":"curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,714[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712260179Z","text":"curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,715[uestProcessor-7] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@323f3a98, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,715[uestProcessor-7] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712744919Z","text":"","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712744919Z","text":"","installer":"org.eclipse.che.exec","stream":"STDERR"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712744919Z","text":"","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,715[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712744919Z","text":"","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,716[uestProcessor-8] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@37925b97, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,716[uestProcessor-8] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712769488Z","text":"gzip: stdin: unexpected end of file","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712769488Z","text":"gzip: stdin: unexpected end of file","installer":"org.eclipse.che.exec","stream":"STDERR"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712769488Z","text":"gzip: stdin: unexpected end of file","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,716[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712769488Z","text":"gzip: stdin: unexpected end of file","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,717[uestProcessor-7] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"curl: (37) Couldn\u0027t open file /home/user/che/exec-agent-linux_amd64.tar.gz","time":"2019-02-19T15:13:17.712260179Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:17,717[uestProcessor-7] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"curl: (37) Couldn\u0027t open file /home/user/che/exec-agent-linux_amd64.tar.gz","time":"2019-02-19T15:13:17.712260179Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,717[uestProcessor-7] [ERROR] [l.ErrorInstallerLogEventLogger 43] - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacegtpqri3p4awwtuhl` text=`curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz` time=`2019-02-19T15:13:17.712260179Z` 2019-02-19 15:13:17,717[uestProcessor-8] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"","time":"2019-02-19T15:13:17.712744919Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:17,717[uestProcessor-9] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@54787a7c, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,717[uestProcessor-9] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,717[uestProcessor-8] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"","time":"2019-02-19T15:13:17.712744919Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,717[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713222253Z","text":"tar: Child returned status 1","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713222253Z","text":"tar: Child returned status 1","installer":"org.eclipse.che.exec","stream":"STDERR"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713222253Z","text":"tar: Child returned status 1","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713222253Z","text":"tar: Child returned status 1","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,718[uestProcessor-8] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@3d146b0d, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,718[uestProcessor-9] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"gzip: stdin: unexpected end of file","time":"2019-02-19T15:13:17.712769488Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:17,718[uestProcessor-8] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,718[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,718[uestProcessor-9] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"gzip: stdin: unexpected end of file","time":"2019-02-19T15:13:17.712769488Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,719[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713240199Z","text":"tar: Error is not recoverable: exiting now","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,719[uestProcessor-9] [ERROR] [l.ErrorInstallerLogEventLogger 43] - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacegtpqri3p4awwtuhl` text=`gzip: stdin: unexpected end of file` time=`2019-02-19T15:13:17.712769488Z` 2019-02-19 15:13:17,719[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713240199Z","text":"tar: Error is not recoverable: exiting now","installer":"org.eclipse.che.exec","stream":"STDERR"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,719[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713240199Z","text":"tar: Error is not recoverable: exiting now","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,719[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,719[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713240199Z","text":"tar: Error is not recoverable: exiting now","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [o.a.t.u.net.SocketWrapperBase 312] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@77fe3815:org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]], Read from buffer: [0] 2019-02-19 15:13:17,725[uestProcessor-9] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@cbea62e, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [o.a.t.util.net.NioEndpoint 1225] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@77fe3815:org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]], Read direct from socket: [1140] 2019-02-19 15:13:17,725[uestProcessor-9] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 80] - Read [1140] bytes into input buffer ready for processing 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,725[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,726[uestProcessor-8] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"tar: Child returned status 1","time":"2019-02-19T15:13:17.713222253Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713681696Z","text":"/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,726[uestProcessor-8] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"tar: Child returned status 1","time":"2019-02-19T15:13:17.713222253Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713681696Z","text":"/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found","installer":"org.eclipse.che.exec","stream":"STDERR"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713681696Z","text":"/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,726[uestProcessor-8] [ERROR] [l.ErrorInstallerLogEventLogger 43] - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacegtpqri3p4awwtuhl` text=`tar: Child returned status 1` time=`2019-02-19T15:13:17.713222253Z` 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713681696Z","text":"/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found","installer":"org.eclipse.che.exec","stream":"STDERR"}} 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,726[uestProcessor-9] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"tar: Error is not recoverable: exiting now","time":"2019-02-19T15:13:17.713240199Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,726[uestProcessor-9] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"tar: Error is not recoverable: exiting now","time":"2019-02-19T15:13:17.713240199Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,726[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,726[uestProcessor-9] [ERROR] [l.ErrorInstallerLogEventLogger 43] - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacegtpqri3p4awwtuhl` text=`tar: Error is not recoverable: exiting now` time=`2019-02-19T15:13:17.713240199Z` 2019-02-19 15:13:17,726[uestProcessor-8] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@7f4b1411, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,727[uestProcessor-8] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"installer/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713916664Z","status":"FAILED","installer":"org.eclipse.che.exec","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}} 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"installer/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713916664Z","status":"FAILED","installer":"org.eclipse.che.exec","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"installer/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713916664Z","status":"FAILED","installer":"org.eclipse.che.exec","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}} 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"installer/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713916664Z","status":"FAILED","installer":"org.eclipse.che.exec","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}} 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,727[nio-8080-exec-6] [DEBUG] [o.a.t.w.server.WsFrameServer 224] - WebSocket frame received. fin [true], rsv [0], OpCode [1], payload length [126] 2019-02-19 15:13:17,728[uestProcessor-9] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@7bad7bf7, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,728[uestProcessor-9] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 102] - Receiving a web socket message. 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 103] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 104] - Message: {"jsonrpc":"2.0","method":"bootstrapper/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713926811Z","status":"FAILED","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}} 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [a.c.j.c.JsonRpcMessageReceiver 64] - Receiving message: {"jsonrpc":"2.0","method":"bootstrapper/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713926811Z","status":"FAILED","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}}, from endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 44] - Validating message: {"jsonrpc":"2.0","method":"bootstrapper/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713926811Z","status":"FAILED","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}} 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 49] - Validation successful 2019-02-19 15:13:17,728[uestProcessor-8] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found","time":"2019-02-19T15:13:17.713681696Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@6bc2378 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 61] - Qualifying message: {"jsonrpc":"2.0","method":"bootstrapper/statusChanged","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.713926811Z","status":"FAILED","error":"Installation 'org.eclipse.che.exec' failed, script exit code is 127"}} 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 64] - Json keys: [method, jsonrpc, params] 2019-02-19 15:13:17,728[uestProcessor-8] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"text":"/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found","time":"2019-02-19T15:13:17.713681696Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","stream":"STDERR","machineName":"dev-machine"} for org.eclipse.che.api.logger.ErrorInstallerLogEventLogger@4c0e48 2019-02-19 15:13:17,728[nio-8080-exec-6] [DEBUG] [c.a.c.j.i.GsonJsonRpcQualifier 69] - Qualified to request 2019-02-19 15:13:17,728[uestProcessor-8] [ERROR] [l.ErrorInstallerLogEventLogger 43] - Installer `org.eclipse.che.exec` error from machine=`dev-machine` owner=`47f31d28-d997-4354-9584-0dab05f6cb59` env=`default` workspace=`workspacegtpqri3p4awwtuhl` text=`/bin/sh: 244: /home/user/che/exec-agent/che-exec-agent: not found` time=`2019-02-19T15:13:17.713681696Z` 2019-02-19 15:13:17,729[nio-8080-exec-6] [DEBUG] [o.a.t.u.net.SocketWrapperBase 312] - Socket: [org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper@77fe3815:org.apache.tomcat.util.net.NioChannel@71b836a9:java.nio.channels.SocketChannel[connected local=/192.168.35.34:8080 remote=/172.16.1.14:60516]], Read from buffer: [0] 2019-02-19 15:13:17,729[uestProcessor-7] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 42] - Dispatching request: org.eclipse.che.api.core.jsonrpc.commons.JsonRpcRequest@172bacf3, endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,729[uestProcessor-9] [DEBUG] [o.e.c.a.c.n.EventService 107] - Publish event {"error":"Installation \u0027org.eclipse.che.exec\u0027 failed, script exit code is 127","time":"2019-02-19T15:13:17.713916664Z","runtimeId":{"ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59","envName":"default","workspaceId":"workspacegtpqri3p4awwtuhl"},"installer":"org.eclipse.che.exec","status":"FAILED","machineName":"dev-machine"} for org.eclipse.che.api.core.notification.RemoteSubscriptionManager$$Lambda$59/701749580@68f90a6a 2019-02-19 15:13:17,729[uestProcessor-7] [DEBUG] [.e.c.a.c.j.c.RequestDispatcher 54] - Request has no ID -> it is a notification 2019-02-19 15:13:17,729[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 141] - Web socket session error 2019-02-19 15:13:17,729[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 142] - Endpoint: 291001359<-:->master-websocket-endpoint 2019-02-19 15:13:17,729[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 143] - Error: {} java.io.EOFException: null at org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.fillReadBuffer(NioEndpoint.java:1289) at org.apache.tomcat.util.net.NioEndpoint$NioSocketWrapper.read(NioEndpoint.java:1223) at org.apache.tomcat.websocket.server.WsFrameServer.onDataAvailable(WsFrameServer.java:72) at org.apache.tomcat.websocket.server.WsFrameServer.doOnDataAvailable(WsFrameServer.java:171) at org.apache.tomcat.websocket.server.WsFrameServer.notifyDataAvailable(WsFrameServer.java:151) at org.apache.tomcat.websocket.server.WsHttpUpgradeHandler.upgradeDispatch(WsHttpUpgradeHandler.java:148) at org.apache.coyote.http11.upgrade.UpgradeProcessorInternal.dispatch(UpgradeProcessorInternal.java:54) at org.apache.coyote.AbstractProcessorLight.process(AbstractProcessorLight.java:53) at org.apache.coyote.AbstractProtocol$ConnectionHandler.process(AbstractProtocol.java:806) at org.apache.tomcat.util.net.NioEndpoint$SocketProcessor.doRun(NioEndpoint.java:1498) at org.apache.tomcat.util.net.SocketProcessorBase.run(SocketProcessorBase.java:49) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) at org.apache.tomcat.util.threads.TaskThread$WrappingRunnable.run(TaskThread.java:61) at java.lang.Thread.run(Thread.java:748) 2019-02-19 15:13:17,730[nio-8080-exec-6] [DEBUG] [a.c.w.i.BasicWebSocketEndpoint 122] - Web socket session closed ```
sleshchenko commented 5 years ago

@mmeliani New error message that I see

{"jsonrpc":"2.0","method":"installer/log","params":{"machineName":"dev-machine","runtimeId":{"workspaceId":"workspacegtpqri3p4awwtuhl","envName":"default","ownerId":"47f31d28-d997-4354-9584-0dab05f6cb59"},"time":"2019-02-19T15:13:17.712260179Z","text":"curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz","installer":"org.eclipse.che.exec","stream":"STDERR"}}

curl: (37) Couldn't open file /home/user/che/exec-agent-linux_amd64.tar.gz

But it does not help us to find a cause. Actually, we don't see an original error that happens during binaries downloading because installer script is too complicated and I missed that, in fact, there is another curl that does downloading, and that one we updated just help unarchive binaries.

You can update installers with the following changes

Exec installer ```json { "version": "1.0.1", "name": "Exec", "dependencies": [], "properties": {}, "servers": { "exec-agent/ws": { "attributes": { "secure": "true", "unsecuredPaths": "/liveness" }, "port": "4412/tcp", "path": "/connect", "protocol": "ws" }, "exec-agent/http": { "attributes": { "secure": "true", "unsecuredPaths": "/liveness" }, "port": "4412/tcp", "path": "/process", "protocol": "http" } }, "id": "org.eclipse.che.exec", "description": "Agent for command execution", "script": "#\n# Copyright (c) 2012-2018 Red Hat, Inc.\n# This program and the accompanying materials are made\n# available under the terms of the Eclipse Public License 2.0\n# which is available at https://www.eclipse.org/legal/epl-2.0/\n#\n# SPDX-License-Identifier: EPL-2.0\n#\n# Contributors:\n# Red Hat, Inc. - initial API and implementation\n#\n\n\nis_current_user_root() {\n test \"$(id -u)\" = 0\n}\n\nis_current_user_sudoer() {\n sudo -n true > /dev/null 2>&1\n}\n\nset_sudo_command() {\n if is_current_user_sudoer && ! is_current_user_root; then SUDO=\"sudo -E\"; else unset SUDO; fi\n}\n\nset_sudo_command\nunset PACKAGES\ncommand -v tar >/dev/null 2>&1 || { PACKAGES=${PACKAGES}\" tar\"; }\nCURL_INSTALLED=false\nWGET_INSTALLED=false\ncommand -v curl >/dev/null 2>&1 && CURL_INSTALLED=true\ncommand -v wget >/dev/null 2>&1 && WGET_INSTALLED=true\n\n# no curl, no wget, install curl\nif [ ${CURL_INSTALLED} = false ] && [ ${WGET_INSTALLED} = false ]; then\n PACKAGES=${PACKAGES}\" curl\";\n CURL_INSTALLED=true\nfi\n\nCHE_DIR=$HOME/che\nLOCAL_AGENT_BINARIES_URI='/mnt/che/exec-agent/exec-agent-${PREFIX}.tar.gz'\nDOWNLOAD_AGENT_BINARIES_URI='${WORKSPACE_MASTER_URI}/agent-binaries/${PREFIX}/exec/exec-agent-${PREFIX}.tar.gz'\nTARGET_AGENT_BINARIES_URI='file://${CHE_DIR}/exec-agent-${PREFIX}.tar.gz'\n\nif [ -f /etc/centos-release ]; then\n FILE=\"/etc/centos-release\"\n LINUX_TYPE=$(cat $FILE | awk '{print $1}')\n elif [ -f /etc/redhat-release ]; then\n FILE=\"/etc/redhat-release\"\n LINUX_TYPE=$(cat $FILE | cut -c 1-8)\n else\n FILE=\"/etc/os-release\"\n LINUX_TYPE=$(cat $FILE | grep ^ID= | tr '[:upper:]' '[:lower:]')\n LINUX_VERSION=$(cat $FILE | grep ^VERSION_ID=)\nfi\nMACHINE_TYPE=$(uname -m)\nSHELL_INTERPRETER=\"/bin/sh\"\n\nmkdir -p ${CHE_DIR}\n${SUDO} mkdir -p /projects\nif is_current_user_sudoer; then\n ${SUDO} sh -c \"chown $(id -u -n) /projects\"\nfi\n\n########################\n### Install packages ###\n########################\n\n# Red Hat Enterprise Linux 7\n############################\nif echo ${LINUX_TYPE} | grep -qi \"rhel\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum install ${PACKAGES};\n }\n\n# Ubuntu 14.04 16.04 / Linux Mint 17\n####################################\nelif echo ${LINUX_TYPE} | grep -qi \"ubuntu\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} apt-get update;\n ${SUDO} apt-get -y install ${PACKAGES};\n }\n\n# Debian 8\n##########\nelif echo ${LINUX_TYPE} | grep -qi \"debian\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} apt-get update;\n ${SUDO} apt-get -y install ${PACKAGES};\n }\n\n# Fedora 23\n###########\nelif echo ${LINUX_TYPE} | grep -qi \"fedora\"; then\n command -v ps >/dev/null 2>&1 || { PACKAGES=${PACKAGES}\" procps-ng\"; }\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} dnf -y install ${PACKAGES};\n }\n\n# CentOS 7.1 & Oracle Linux 7.1\n###############################\nelif echo ${LINUX_TYPE} | grep -qi \"centos\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum -y install ${PACKAGES};\n }\n\n# openSUSE 13.2\n###############\nelif echo ${LINUX_TYPE} | grep -qi \"opensuse\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} zypper install -y ${PACKAGES};\n }\n\n# Alpine 3.3\n############\nelif echo ${LINUX_TYPE} | grep -qi \"alpine\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} apk update\n ${SUDO} apk add ${PACKAGES};\n }\n\n# Centos 6.6, 6.7, 6.8\n############\nelif echo ${LINUX_TYPE} | grep -qi \"CentOS\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum -y install ${PACKAGES};\n }\n\n# Red Hat Enterprise Linux 6\n############################\n\nelif echo ${LINUX_TYPE} | grep -qi \"Red Hat\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum install ${PACKAGES};\n }\n\nelse\n >&2 echo \"Unrecognized Linux Type\"\n >&2 cat $FILE\n exit 1\nfi\n\n\n########################\n### Install Exec agent ###\n########################\nif echo ${MACHINE_TYPE} | grep -qi \"x86_64\"; then\n PREFIX=linux_amd64\nelif echo ${MACHINE_TYPE} | grep -qi \"arm5\"; then\n PREFIX=linux_arm7\nelif echo ${MACHINE_TYPE} | grep -qi \"arm6\"; then\n PREFIX=linux_arm7\nelif echo ${MACHINE_TYPE} | grep -qi \"arm7\"; then\n PREFIX=linux_arm7\nelif echo ${MACHINE_TYPE} | grep -qi \"armv7l\"; then\n PREFIX=linux_arm7\nelse\n >&2 echo \"Unrecognized Machine Type\"\n >&2 uname -a\n exit 1\nfi\n\n# Compute URI of workspace master\nWORKSPACE_MASTER_URI=$(echo $CHE_API | cut -d / -f 1-3)\n\n## Evaluate variables now that prefix is defined\neval \"LOCAL_AGENT_BINARIES_URI=${LOCAL_AGENT_BINARIES_URI}\"\neval \"DOWNLOAD_AGENT_BINARIES_URI=${DOWNLOAD_AGENT_BINARIES_URI}\"\neval \"TARGET_AGENT_BINARIES_URI=${TARGET_AGENT_BINARIES_URI}\"\n\nLOCAL_AGENT_PATH=\nif [ -f \"${LOCAL_AGENT_BINARIES_URI}\" ]; then\n AGENT_BINARIES_URI=\"file://${LOCAL_AGENT_BINARIES_URI}\"\n LOCAL_AGENT_PATH=${LOCAL_AGENT_BINARIES_URI}\nelif [ -f $(echo \"${LOCAL_AGENT_BINARIES_URI}\" | sed \"s/-${PREFIX}//g\") ]; then\n AGENT_BINARIES_URI=\"file://\"$(echo \"${LOCAL_AGENT_BINARIES_URI}\" | sed \"s/-${PREFIX}//g\")\n LOCAL_AGENT_PATH=$(echo \"${LOCAL_AGENT_BINARIES_URI}\" | sed \"s/-${PREFIX}//g\")\nelse\n AGENT_BINARIES_URI=${DOWNLOAD_AGENT_BINARIES_URI}\nfi\n\n# If file is already on the filesystem, use it\nif [ ! -z ${LOCAL_AGENT_PATH} ]; then\n tar zxf ${LOCAL_AGENT_PATH} -C ${CHE_DIR}\nelse\n echo \"Exec Agent binary is downloaded remotely\"\n # Use curl\n if [ ${CURL_INSTALLED} = true ]; then\n\n CA_ARG=\"\"\n if [ -f /tmp/che/secret/ca.crt ]; then\n echo \"Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading\"\n CA_ARG=\"--cacert /tmp/che/secret/ca.crt\"\n fi\n\n if curl ${CA_ARG} -o /dev/null --silent --head --fail $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g'); then\n curl -sSf ${CA_ARG} -o $(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g' | sed 's/file:\\/\\///g') $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\n elif curl ${CA_ARG} -o /dev/null --silent --head --fail $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g'); then\n curl -sSf ${CA_ARG} -o $(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g' | sed 's/file:\\/\\///g') $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\n else\n # both of test curl commands failed.\n # perform them without --silent option to propagate errors\n echo \"Trying: curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\"\n curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\n echo \"Trying: curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\"\n curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\n fi\n curl -sSf $(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g') | tar xzf - -C ${CHE_DIR}\n else\n CA_ARG=\"\"\n if [ -f /tmp/che/secret/ca.crt ]; then\n echo \"Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading\"\n CA_ARG=\"--ca-certificate /tmp/che/secret/ca.crt\"\n fi\n\n # replace https by http as wget may not be able to handle ssl\n AGENT_BINARIES_URI=$(echo ${AGENT_BINARIES_URI} | sed 's/https/http/g')\n\n # use wget\n WGET_SPIDER=\"wget --spider\"\n if wget 2>&1 | grep -q BusyBox; then\n WGET_SPIDER=\"wget -s\"\n fi\n LOCAL_DOWNLOAD=$(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g' | sed 's/file:\\/\\///g')\n if ${WGET_SPIDER} ${CA_ARG} -q $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g') >/dev/null; then\n wget ${CA_ARG} -qO ${LOCAL_DOWNLOAD} $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\n elif ${WGET_SPIDER} ${CA_ARG} -q $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g'); then\n wget ${CA_ARG} -qO- ${LOCAL_DOWNLOAD} $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\n fi\n tar xzf ${LOCAL_DOWNLOAD} -C ${CHE_DIR}\n fi\nfi\n\n\n\nif [ -f /bin/bash ]; then\n SHELL_INTERPRETER=\"/bin/bash\"\nfi\n\nEXEC_AGENT_PORT=${CHE_SERVER_EXEC_AGENT_HTTP_PORT:-4412}\n\n\nLOGS_DIR=''\n## Checks whether workspace logs root exists if it does override exec-agent logs directory otherwise default folder would be used\nif [ -d \"${CHE_WORKSPACE_LOGS_ROOT__DIR}\" ]; then\n LOGS_DIR=$CHE_WORKSPACE_LOGS_ROOT__DIR/exec-agent\nelse\n LOGS_DIR=$HOME/che/exec-agent/logs\nfi\n\n$HOME/che/exec-agent/che-exec-agent -addr :${EXEC_AGENT_PORT} -cmd ${SHELL_INTERPRETER} -logs-dir $LOGS_DIR\n" } ```
Terminal installer ```json { "version": "1.0.1", "name": "Terminal", "dependencies": [], "properties": {}, "servers": { "terminal": { "attributes": { "secure": "true", "unsecuredPaths": "/liveness" }, "port": "4411/tcp", "path": "/pty", "protocol": "ws" } }, "id": "org.eclipse.che.terminal", "description": "Embedded web terminal", "script": "#\n# Copyright (c) 2012-2018 Red Hat, Inc.\n# This program and the accompanying materials are made\n# available under the terms of the Eclipse Public License 2.0\n# which is available at https://www.eclipse.org/legal/epl-2.0/\n#\n# SPDX-License-Identifier: EPL-2.0\n#\n# Contributors:\n# Red Hat, Inc. - initial API and implementation\n#\n\nis_current_user_root() {\n test \"$(id -u)\" = 0\n}\n\nis_current_user_sudoer() {\n sudo -n true > /dev/null 2>&1\n}\n\nset_sudo_command() {\n if is_current_user_sudoer && ! is_current_user_root; then SUDO=\"sudo -E\"; else unset SUDO; fi\n}\n\nset_sudo_command\nunset PACKAGES\ncommand -v tar >/dev/null 2>&1 || { PACKAGES=${PACKAGES}\" tar\"; }\nCURL_INSTALLED=false\nWGET_INSTALLED=false\ncommand -v curl >/dev/null 2>&1 && CURL_INSTALLED=true\ncommand -v wget >/dev/null 2>&1 && WGET_INSTALLED=true\n\n# no curl, no wget, install curl\nif [ ${CURL_INSTALLED} = false ] && [ ${WGET_INSTALLED} = false ]; then\n PACKAGES=${PACKAGES}\" curl\";\n CURL_INSTALLED=true\nfi\n\nCHE_DIR=$HOME/che\nLOCAL_AGENT_BINARIES_URI='/mnt/che/terminal/websocket-terminal-${PREFIX}.tar.gz'\nDOWNLOAD_AGENT_BINARIES_URI='${WORKSPACE_MASTER_URI}/agent-binaries/${PREFIX}/terminal/websocket-terminal-${PREFIX}.tar.gz'\nTARGET_AGENT_BINARIES_URI='file://${CHE_DIR}/websocket-terminal-${PREFIX}.tar.gz'\n\nif [ -f /etc/centos-release ]; then\n FILE=\"/etc/centos-release\"\n LINUX_TYPE=$(cat $FILE | awk '{print $1}')\n elif [ -f /etc/redhat-release ]; then\n FILE=\"/etc/redhat-release\"\n LINUX_TYPE=$(cat $FILE | cut -c 1-8)\n else\n FILE=\"/etc/os-release\"\n LINUX_TYPE=$(cat $FILE | grep ^ID= | tr '[:upper:]' '[:lower:]')\n LINUX_VERSION=$(cat $FILE | grep ^VERSION_ID=)\nfi\nMACHINE_TYPE=$(uname -m)\nSHELL_INTERPRETER=\"/bin/sh\"\n\n\nmkdir -p ${CHE_DIR}\n\n########################\n### Install packages ###\n########################\n\n# Red Hat Enterprise Linux 7 \n############################\nif echo ${LINUX_TYPE} | grep -qi \"rhel\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum install ${PACKAGES};\n }\n\n# Ubuntu 14.04 16.04 / Linux Mint 17 \n####################################\nelif echo ${LINUX_TYPE} | grep -qi \"ubuntu\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} apt-get update;\n ${SUDO} apt-get -y install ${PACKAGES};\n }\n\n# Debian 8\n##########\nelif echo ${LINUX_TYPE} | grep -qi \"debian\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} apt-get update;\n ${SUDO} apt-get -y install ${PACKAGES};\n }\n\n# Fedora 23 \n###########\nelif echo ${LINUX_TYPE} | grep -qi \"fedora\"; then\n command -v ps >/dev/null 2>&1 || { PACKAGES=${PACKAGES}\" procps-ng\"; }\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} dnf -y install ${PACKAGES};\n }\n\n# CentOS 7.1 & Oracle Linux 7.1\n###############################\nelif echo ${LINUX_TYPE} | grep -qi \"centos\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum -y install ${PACKAGES};\n }\n\n# openSUSE 13.2\n###############\nelif echo ${LINUX_TYPE} | grep -qi \"opensuse\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} zypper install -y ${PACKAGES};\n }\n\n# Alpine 3.3\n############\nelif echo ${LINUX_TYPE} | grep -qi \"alpine\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} apk update\n ${SUDO} apk add ${PACKAGES};\n }\n\n# Centos 6.6, 6.7, 6.8\n############\nelif echo ${LINUX_TYPE} | grep -qi \"CentOS\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum -y install ${PACKAGES};\n }\n\n# Red Hat Enterprise Linux 6 \n############################\n\nelif echo ${LINUX_TYPE} | grep -qi \"Red Hat\"; then\n test \"${PACKAGES}\" = \"\" || {\n ${SUDO} yum install ${PACKAGES};\n }\n\nelse\n >&2 echo \"Unrecognized Linux Type\"\n >&2 cat $FILE\n exit 1\nfi\n\n########################\n### Install Terminal ###\n########################\nif echo ${MACHINE_TYPE} | grep -qi \"x86_64\"; then\n PREFIX=linux_amd64\nelif echo ${MACHINE_TYPE} | grep -qi \"arm5\"; then\n PREFIX=linux_arm7\nelif echo ${MACHINE_TYPE} | grep -qi \"arm6\"; then\n PREFIX=linux_arm7\nelif echo ${MACHINE_TYPE} | grep -qi \"arm7\"; then\n PREFIX=linux_arm7\nelif echo ${MACHINE_TYPE} | grep -qi \"armv7l\"; then\n PREFIX=linux_arm7\nelse\n >&2 echo \"Unrecognized Machine Type\"\n >&2 uname -a\n exit 1\nfi\n\n# Compute URI of workspace master\nWORKSPACE_MASTER_URI=$(echo $CHE_API | cut -d / -f 1-3)\n\n## Evaluate variables now that prefix is defined\neval \"LOCAL_AGENT_BINARIES_URI=${LOCAL_AGENT_BINARIES_URI}\"\neval \"DOWNLOAD_AGENT_BINARIES_URI=${DOWNLOAD_AGENT_BINARIES_URI}\"\neval \"TARGET_AGENT_BINARIES_URI=${TARGET_AGENT_BINARIES_URI}\"\n\nLOCAL_AGENT_PATH=\nif [ -f \"${LOCAL_AGENT_BINARIES_URI}\" ]; then\n AGENT_BINARIES_URI=\"file://${LOCAL_AGENT_BINARIES_URI}\"\n LOCAL_AGENT_PATH=${LOCAL_AGENT_BINARIES_URI}\nelif [ -f $(echo \"${LOCAL_AGENT_BINARIES_URI}\" | sed \"s/-${PREFIX}//g\") ]; then\n AGENT_BINARIES_URI=\"file://\"$(echo \"${LOCAL_AGENT_BINARIES_URI}\" | sed \"s/-${PREFIX}//g\")\n LOCAL_AGENT_PATH=$(echo \"${LOCAL_AGENT_BINARIES_URI}\" | sed \"s/-${PREFIX}//g\")\nelse\n AGENT_BINARIES_URI=${DOWNLOAD_AGENT_BINARIES_URI}\nfi\n\n# If file is already on the filesystem, use it\nif [ ! -z ${LOCAL_AGENT_PATH} ]; then\n tar zxf ${LOCAL_AGENT_PATH} -C ${CHE_DIR}\nelse\n echo \"Terminal Agent binary is downloaded remotely\"\n # Use curl\n if [ ${CURL_INSTALLED} = true ]; then\n\n CA_ARG=\"\"\n if [ -f /tmp/che/secret/ca.crt ]; then\n echo \"Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading\"\n CA_ARG=\"--cacert /tmp/che/secret/ca.crt\"\n fi\n\n if curl ${CA_ARG} -o /dev/null --silent --head --fail $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g'); then\n curl -sSf ${CA_ARG} -o $(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g' | sed 's/file:\\/\\///g') $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\n elif curl ${CA_ARG} -o /dev/null --silent --head --fail $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g'); then\n curl -sSf ${CA_ARG} -o $(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g' | sed 's/file:\\/\\///g') $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\n else\n # both of test curl commands failed.\n # perform them without --silent option to propagate errors\n echo \"Trying: curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\"\n curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\n echo \"Trying: curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\"\n curl -sSf ${CA_ARG} -o /dev/null --head $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\n fi\n curl -sSf $(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g') | tar xzf - -C ${CHE_DIR}\n else\n CA_ARG=\"\"\n if [ -f /tmp/che/secret/ca.crt ]; then\n echo \"Certificate File /tmp/che/secret/ca.crt will be used for binaries downloading\"\n CA_ARG=\"--ca-certificate /tmp/che/secret/ca.crt\"\n fi\n\n # replace https by http as wget may not be able to handle ssl\n AGENT_BINARIES_URI=$(echo ${AGENT_BINARIES_URI} | sed 's/https/http/g')\n\n # use wget\n WGET_SPIDER=\"wget --spider\"\n if wget 2>&1 | grep -q BusyBox; then\n WGET_SPIDER=\"wget -s\"\n fi\n LOCAL_DOWNLOAD=$(echo ${TARGET_AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g' | sed 's/file:\\/\\///g')\n if ${WGET_SPIDER} ${CA_ARG} -q $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g') >/dev/null; then\n wget ${CA_ARG} -qO ${LOCAL_DOWNLOAD} $(echo ${AGENT_BINARIES_URI} | sed 's/\\${PREFIX}/'${PREFIX}'/g')\n elif ${WGET_SPIDER} ${CA_ARG} -q $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g'); then\n wget ${CA_ARG} -qO- ${LOCAL_DOWNLOAD} $(echo ${AGENT_BINARIES_URI} | sed 's/-\\${PREFIX}//g')\n fi\n tar xzf ${LOCAL_DOWNLOAD} -C ${CHE_DIR}\n fi\nfi\n\n\n\nif [ -f /bin/bash ]; then\n SHELL_INTERPRETER=\"/bin/bash\"\nfi\n\nTERMINAL_PORT=${CHE_SERVER_TERMINAL_PORT:-4411}\n\n$HOME/che/terminal/che-websocket-terminal -addr :${TERMINAL_PORT} -cmd ${SHELL_INTERPRETER}\n" } ```

It's installers content with the following changes applied https://github.com/eclipse/che/pull/12704

mmeliani commented 5 years ago

i investigated further and was a permission denied so always set security context to 1000 in order to start correctly workspaces Thanks for you support will close the ticket