Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Bump kubernetes-client to 3.1.10 #271

Merged
merged 7 commits into from
Mar 16, 2018
Merged

Bump kubernetes-client to 3.1.10 #271

merged 7 commits into from
Mar 16, 2018

Conversation

carlossg
Copy link
Contributor

@carlossg carlossg commented Jan 9, 2018

No description provided.

@carlossg
Copy link
Contributor Author

The command execution in v3 is a lot slower than in v2, all the times I've tried there is a consistent gap of 30 seconds where nothing happens
@iocanel any ideas?

Jan 21, 2018 10:48:57 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:48:58 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:48:59 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesCloud connect
FINE: Building connection to Kubernetes kubernetes URL null namespace null
Jan 21, 2018 10:48:59 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesFactoryAdapter createClient
FINE: Autoconfiguring Kubernetes client
Jan 21, 2018 10:48:59 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:48:59 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:48:59 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesFactoryAdapter createClient
FINE: Creating Kubernetes client: KubernetesFactoryAdapter [serviceAddress=null, namespace=null, caCertData=null, credentials=null, skipTlsVerify=false, connectTimeout=0, readTimeout=0]
Jan 21, 2018 10:48:59 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesCloud connect
FINE: Connected to Kubernetes kubernetes URL null
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesTestUtil setupCloud
INFO: Using namespace kubernetes-plugin-test for branch null
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesCloud connect
FINE: Building connection to Kubernetes kubernetes URL null namespace kubernetes-plugin-test
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesFactoryAdapter createClient
FINE: Autoconfiguring Kubernetes client
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesFactoryAdapter createClient
FINE: Creating Kubernetes client: KubernetesFactoryAdapter [serviceAddress=null, namespace=kubernetes-plugin-test, caCertData=null, credentials=null, skipTlsVerify=false, connectTimeout=0, readTimeout=0]
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesCloud connect
FINE: Connected to Kubernetes kubernetes URL null
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesCloud connect
FINE: Building connection to Kubernetes kubernetes URL null namespace kubernetes-plugin-test
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesFactoryAdapter createClient
FINE: Autoconfiguring Kubernetes client
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesFactoryAdapter createClient
FINE: Creating Kubernetes client: KubernetesFactoryAdapter [serviceAddress=null, namespace=kubernetes-plugin-test, caCertData=null, credentials=null, skipTlsVerify=false, connectTimeout=0, readTimeout=0]
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesCloud connect
FINE: Connected to Kubernetes kubernetes URL null
Jan 21, 2018 10:49:00 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesTestUtil deletePods
WARNING: Deleting leftover pods: [test-command-execution-m2njr (Running)]
Created pod: test-command-execution-sc5ps
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@5bd3973e
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@5ced3abf
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@76d52aaa
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@5fd54b7b
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@356445af
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@1f83c4b2
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@30e9ec4b
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@600b07a0
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@396a88ed
Jan 21, 2018 10:49:00 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager runWatch
FINE: Connecting websocket ... io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@36439271
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@5fd54b7b
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@2c869ffd
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@5bd3973e
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@5ced3abf
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@78ff7799
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@76d52aaa
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@7c492df7
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@7cc9a18e
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@356445af
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@2ee3679
Jan 21, 2018 10:49:01 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:01 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:01 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:01 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:01 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:01 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onOpen
FINE: WebSocket successfully opened
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@600b07a0
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@6ecce5d1
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@1f83c4b2
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@e5cacfb
Jan 21, 2018 10:49:31 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@30e9ec4b
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@75eb6432
Jan 21, 2018 10:49:31 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@396a88ed
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@37ad61b0
Jan 21, 2018 10:49:31 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager close
FINE: Force closing the watch io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager@36439271
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager closeWebSocket
FINE: Closing websocket okhttp3.internal.ws.RealWebSocket@327c1061
Jan 21, 2018 10:49:31 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1 doLaunch
FINEST: Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.Config tryKubeConfig
FINE: Trying to configure client from Kubernetes config...
Executing shell script inside container [busybox] of pod [test-command-execution-sc5ps]
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onFailure
FINE: Ignoring onFailure for already closed/closing websocket
java.io.IOException: closed
	at okhttp3.internal.ws.WebSocketWriter.writeControlFrame(WebSocketWriter.java:112)
	at okhttp3.internal.ws.WebSocketWriter.writePing(WebSocketWriter.java:75)
	at okhttp3.internal.ws.RealWebSocket.writePingFrame(RealWebSocket.java:528)
	at okhttp3.internal.ws.RealWebSocket$PingRunnable.run(RealWebSocket.java:516)
	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
	at java.lang.Thread.run(Thread.java:745)

Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: WebSocket close received. code: 1000, reason: 
Jan 21, 2018 10:49:31 AM io.fabric8.kubernetes.client.dsl.internal.WatchConnectionManager$2 onClosed
FINE: Ignoring onClose for already closed/closing websocket
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@1135e805[Count = 1])
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@6bd9133c[Count = 1])
pid is 10
EXITCOExecuting command: DE "sh"  "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
 Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

0pid is 10
EXITCODE   0Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@2441b827[Count = 1])
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@16e9d0af[Count = 1])
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@526a6485[Count = 1])
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@1135e805[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@1135e805[Count = 0])
Thread 2 finished
pid is 16
EXITCODE   0pid is 16
EXITCODE   0pid is 21
EXITCODE   0pid is 21
EXITCODE   0Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@177fdbb3[Count = 1])
pid is 26
EXITCODE   0pid is 26
EXITCODE   0Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
pid is 31
pid is 31
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
EXITCODE   0EXITCODE   0Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@2441b827[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@6bd9133c[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@2441b827[Count = 0])
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@6bd9133c[Count = 0])
Thread 0 finished
Thread 4 finished
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@526a6485[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@526a6485[Count = 0])
Thread 3 finished
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
pid iJan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@16e9d0af[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@16e9d0af[Count = 0])
Thread 7 finished
s 37
pid is 37
EXITCODE   0EXITCODE   0Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@177fdbb3[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@177fdbb3[Count = 0])
Thread 8 finished
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@4d16e095[Count = 1])
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@20241a02[Count = 1])
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@6d0f41ea[Count = 1])
Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator doExec
FINEST: Executing command: "sh" "-c" "cd /tmp; echo pid is \$\$ > test; cat /tmp/test" 
printf "EXITCODE %3d" $?; exit

Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Waiting for websocket to close on command finish (java.util.concurrent.CountDownLatch@4643eebb[Count = 1])
pid is 42
EXITCODE   0pid is 42
EXITCODE   0pid is 48
EXITCODE   0pid is 48
EXITCODE   0pid is 55
pid is 55
EXITCODE   0EXITCODE   0Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
pid is 60
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@20241a02[Count = 1]
EXITCODE   0pid is 60
EXITCODE   0Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@20241a02[Count = 0])
Thread 6 finished
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@4d16e095[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@4d16e095[Count = 0])
Thread 1 finished
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
Jan 21, 2018 10:49:32 AM io.fabric8.kubernetes.client.dsl.internal.ExecWebSocketListener onClosed
FINE: Exec Web Socket: On Close with code:[1000], due to: []
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@4643eebb[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecDecorator$1$1 onClose
FINEST: onClose : java.util.concurrent.CountDownLatch@6d0f41ea[Count = 1]
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@4643eebb[Count = 0])
Thread 9 finished
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.pipeline.ContainerExecProc join
FINEST: Command is finished (java.util.concurrent.CountDownLatch@6d0f41ea[Count = 0])
Thread 5 finished
Jan 21, 2018 10:49:32 AM org.csanchez.jenkins.plugins.kubernetes.KubernetesTestUtil deletePods
WARNING: Deleting leftover pods: [test-command-execution-sc5ps (Running)]

There is a wait of 30 seconds somewhere
@carlossg
Copy link
Contributor Author

Up to 5 threads in the testCommandExecution is fine, over that there is the 30 seconds wait. Some threads may finish in a second, rest will finish after the 30 secs

@iocanel
Copy link
Contributor

iocanel commented Jan 21, 2018

@carlossg: OOTB the client supprts up to 5 concurrent requests per host (see 1). This is actually passed to okhttp and I am not quite sure how it handles it internally, but it does look very suspicious.

Can you try increasin that number and see if that makes any difference?

Also, I think that its essential to merge this: #239 as it will dramatically reduce the number of requests.

@carlossg
Copy link
Contributor Author

carlossg commented Jan 29, 2018

Actually this test broke between kubernetes-client 2.6.2 and 2.6.3

#239 did not solve it

carlossg added a commit to carlossg/kubernetes-client that referenced this pull request Jan 30, 2018
carlossg added a commit to carlossg/kubernetes-client that referenced this pull request Jan 30, 2018
@carlossg
Copy link
Contributor Author

The changes in PR fabric8io/kubernetes-client#855 broke the test, from v2.6.3 to v3.1.6 (included). Threads would hang forever on waitUntilReady

In 3.1.7+ the problem is different, it will eventually succeed, but with 30 second pauses

I've filed fabric8io/kubernetes-client#997

@carlossg
Copy link
Contributor Author

carlossg commented Mar 6, 2018

Waiting for a release > 3.1.8 with fabric8io/kubernetes-client@83eda0c

@carlossg carlossg changed the title Bump kubernetes-client to 3.1.8 Bump kubernetes-client to 3.1.10 Mar 16, 2018
@carlossg carlossg merged commit 207e0ea into master Mar 16, 2018
@carlossg carlossg deleted the kubernetes-client-v3 branch March 16, 2018 20:10
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

Successfully merging this pull request may close these issues.

2 participants