This job view page is being replaced by Spyglass soon. Check out the new job view.
ResultFAILURE
Tests 0 failed / 29 succeeded
Started2019-10-23 17:12
Elapsed50m31s
Revision6ab2e10869e3e2443ae8d92d3489905bc0c987f5
Refs 1323

No Test Failures!


Show 29 Passed Tests

Show 7 Skipped Tests

Error lines from build-log.txt

... skipping 72 lines ...
....................................................................................................................Updated [https://www.googleapis.com/compute/v1/projects/cri-containerd-node-e2e].
.done.
Waiting for SSH key to propagate.
ssh: connect to host 35.247.51.11 port 22: Connection refused
ssh: connect to host 35.247.51.11 port 22: Connection refused
ssh: connect to host 35.247.51.11 port 22: Connection refused
ERROR: (gcloud.compute.ssh) Could not SSH into the instance.  It is possible that your SSH key has not propagated to the instance yet. Try running this command again.  If you still cannot connect, verify that the firewall and instance are set to accept ssh traffic.
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:14:16 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:14:16 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.nMis1EoZ70
Warning: Permanently added 'compute.7218261458790725394' (ECDSA) to the list of known hosts.
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:15:27 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:15:27 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.nMis1EoZ70
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:15:34 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:15:34 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
ssh ready
+ rm /tmp/tmp.ShZDxsXqp6/tmp.nMis1EoZ70
+ log 'Setup test environment in the test instance'
++ date
... skipping 258 lines ...
+ local attempts=1
++ mktemp -p /tmp/tmp.ShZDxsXqp6
+ local -r stderr=/tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
ssh: connect to host 35.247.51.11 port 22: Connection refused
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:23:55 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:23:55 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:07 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:07 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:14 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:14 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:22 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:22 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:29 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:29 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:37 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:37 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:44 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:44 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:51 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:51 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
+ cat /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.ssh) [/usr/bin/ssh] exited with return code [255].
+ ((  attempts++  ))
+ [[ -n '' ]]
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:24:59 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...'
Wed Oct 23 17:24:59 UTC 2019 gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de --command=echo ssh ready failed, retry in 5 second...
+ sleep 5
+ gcloud compute ssh --ssh-flag=-ServerAliveInterval=30 windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de '--command=echo ssh ready'
ssh ready
+ rm /tmp/tmp.ShZDxsXqp6/tmp.TCp1Ce7lYw
+ log 'Run test on the test instance'
++ date
... skipping 11 lines ...
++ mktemp -p /tmp/tmp.ShZDxsXqp6
+ local -r stderr=/tmp/tmp.ShZDxsXqp6/tmp.NVmtmYQDGX
+ gcloud compute scp /home/prow/go/src/github.com/containerd/cri/test/windows/../../test/windows/test.sh windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.sh
+ cat /tmp/tmp.ShZDxsXqp6/tmp.NVmtmYQDGX
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
lost connection
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
+ ((  attempts++  ))
+ [[ -n Permission denied ]]
+ grep 'Permission denied' /tmp/tmp.ShZDxsXqp6/tmp.NVmtmYQDGX
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute scp /home/prow/go/src/github.com/containerd/cri/test/windows/../../test/windows/test.sh windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.sh failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 17:25:15 UTC 2019 gcloud compute scp /home/prow/go/src/github.com/containerd/cri/test/windows/../../test/windows/test.sh windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.sh failed, retry in 5 second...'
Wed Oct 23 17:25:15 UTC 2019 gcloud compute scp /home/prow/go/src/github.com/containerd/cri/test/windows/../../test/windows/test.sh windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.sh failed, retry in 5 second...
+ sleep 5
+ gcloud compute scp /home/prow/go/src/github.com/containerd/cri/test/windows/../../test/windows/test.sh windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.sh
+ rm /tmp/tmp.ShZDxsXqp6/tmp.NVmtmYQDGX
+ retry_on_permission_error gcloud compute scp /tmp/cri.tar.gz windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/cri.tar.gz
+ retry_on_error 36 5 'Permission denied' gcloud compute scp /tmp/cri.tar.gz windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/cri.tar.gz
+ local -r MAX_ATTEMPTS=36
... skipping 31 lines ...
+ local attempts=1
++ mktemp -p /tmp/tmp.ShZDxsXqp6
+ local -r stderr=/tmp/tmp.ShZDxsXqp6/tmp.X4ZzVypzuu
+ gcloud compute scp windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.log /logs/artifacts
+ cat /tmp/tmp.ShZDxsXqp6/tmp.X4ZzVypzuu
prow@35.247.51.11: Permission denied (publickey,keyboard-interactive).
ERROR: (gcloud.compute.scp) [/usr/bin/scp] exited with return code [1].
+ ((  attempts++  ))
+ [[ -n Permission denied ]]
+ grep 'Permission denied' /tmp/tmp.ShZDxsXqp6/tmp.X4ZzVypzuu
+ ((  attempts > MAX_ATTEMPTS  ))
+ log 'gcloud compute scp windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.log /logs/artifacts failed, retry in 5 second...'
++ date
+ echo 'Wed Oct 23 18:01:34 UTC 2019 gcloud compute scp windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.log /logs/artifacts failed, retry in 5 second...'
Wed Oct 23 18:01:34 UTC 2019 gcloud compute scp windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.log /logs/artifacts failed, retry in 5 second...
+ sleep 5
+ gcloud compute scp windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/test.log /logs/artifacts
+ rm /tmp/tmp.ShZDxsXqp6/tmp.X4ZzVypzuu
+ retry_on_permission_error gcloud compute scp --recurse 'windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/_artifacts/*' /logs/artifacts
+ retry_on_error 36 5 'Permission denied' gcloud compute scp --recurse 'windows-cri-2b934980-fdea-4fbc-adde-129b4a9954de:C:/_artifacts/*' /logs/artifacts
+ local -r MAX_ATTEMPTS=36
... skipping 391 lines ...

STEP: start container
STEP: Start container for containerID: a8bd2168d57f8047ae34927c88e45f3d46e2b32158d7df4ec6910b2019b89841
Oct 23 17:53:57.158: INFO: Started container "a8bd2168d57f8047ae34927c88e45f3d46e2b32158d7df4ec6910b2019b89841"

STEP: test execSync with timeout
E1023 17:53:58.532084    4072 remote_runtime.go:351] ExecSync a8bd2168d57f8047ae34927c88e45f3d46e2b32158d7df4ec6910b2019b89841 'powershell -c sleep 4321' from runtime service failed: rpc error: code = DeadlineExceeded desc = failed to exec in container: timeout 1s exceeded: context deadline exceeded
STEP: timeout exec process should be gone
[AfterEach] runtime should support basic operations on container
  C:/Users/prow/AppData/Local/Temp/cri-install-crictl.KxK2/src/github.com/kubernetes-sigs/cri-tools/pkg/validate/container.go:76
STEP: stop PodSandbox
STEP: delete PodSandbox
[AfterEach] [k8s.io] Container
... skipping 325 lines ...
STEP: List PodSandbox for podID: 3c988353959ca52fedfb0b4e183e333cf9f1a46c0f1c1f194a76b967433005c5
STEP: List PodSandbox.
Oct 23 17:56:49.469: INFO: List PodSandbox succeed
[AfterEach] runtime should support basic operations on PodSandbox
  C:/Users/prow/AppData/Local/Temp/cri-install-crictl.KxK2/src/github.com/kubernetes-sigs/cri-tools/pkg/validate/pod.go:44
STEP: stop PodSandbox
E1023 17:56:49.470565    4072 remote_runtime.go:128] StopPodSandbox "3c988353959ca52fedfb0b4e183e333cf9f1a46c0f1c1f194a76b967433005c5" from runtime service failed: rpc error: code = Unknown desc = an error occurred when try to find sandbox "3c988353959ca52fedfb0b4e183e333cf9f1a46c0f1c1f194a76b967433005c5": does not exist
STEP: delete PodSandbox
[AfterEach] [k8s.io] PodSandbox
  C:/Users/prow/AppData/Local/Temp/cri-install-crictl.KxK2/src/github.com/kubernetes-sigs/cri-tools/pkg/framework/framework.go:51
+S
------------------------------
[k8s.io] Image Manager 
... skipping 95 lines ...