Error from server (NotFound): namespaces "devfile-proxy" not found Using Devfile proxy: cp ododevapispec.yaml pkg/apiserver-impl/swagger-ui/swagger.yaml go install -mod=vendor -ldflags="-X github.com/redhat-developer/odo/pkg/version.GITCOMMIT=876d43c0d" ./cmd/odo/ go run -mod=vendor github.com/onsi/ginkgo/v2/ginkgo --randomize-all --poll-progress-after=120s --poll-progress-interval=120s -timeout 14400s --no-color -nodes=16 --junit-report="test-integration.xml" --label-filter="!unauth && !nocluster && !podman" tests/integration Running Suite: Integration Suite - /go/odo_1/tests/integration ============================================================== Random Seed: 1698071631 - will randomize all specs Will run 504 of 956 specs Running in parallel across 16 processes SSSSSSSSSSSSSSSSSSSS•SSSS••S•SS•S ------------------------------ • [17.998 seconds] odo deploy interactive command tests directory is not empty when there is a match from Alizer should display welcoming messages first /go/odo_1/tests/integration/interactive_deploy_test.go:109 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo deploy' from /tmp/2478114058 << Captured StdOut/StdErr Output ------------------------------ S••SS••SS•SSS•SS••S•SSS•S•S•SSSSSS••••S•S••• ------------------------------ • [13.406 seconds] odo dev interactive command tests directory is not empty when Alizer cannot determine a Devfile based on the current source code should not fail but fallback to the interactive mode /go/odo_1/tests/integration/interactive_dev_test.go:164 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo dev --random-ports' from /tmp/1848040157 << Captured StdOut/StdErr Output ------------------------------ SSS•S•SSSSS••SS••SS• ------------------------------ • [4.035 seconds] odo deploy interactive command tests directory is not empty when there is a match from Alizer should run alizer to download devfile successfully even with -v flag /go/odo_1/tests/integration/interactive_deploy_test.go:40 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo deploy -v 4' from /tmp/2182306358 << Captured StdOut/StdErr Output ------------------------------ S••••S••SS•S•S••SSSSSSSSS•••S•S•SS•S••S••SSSS••S•S•SS•••S•••SS•SSSS•••S•S•S•••• ------------------------------ • [5.589 seconds] odo deploy interactive command tests directory is not empty when there is a match from Alizer should run alizer to download devfile /go/odo_1/tests/integration/interactive_deploy_test.go:75 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo deploy' from /tmp/2593669289 << Captured StdOut/StdErr Output ------------------------------ •S•SS•S•• ------------------------------ • [80.680 seconds] odo dev interactive command tests directory is not empty when there is a match from Alizer should run alizer to download devfile /go/odo_1/tests/integration/interactive_dev_test.go:76 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo dev --random-ports' from /tmp/2585775171 << Captured StdOut/StdErr Output ------------------------------ SS•SS•S•SSSSSSS• ------------------------------ • [83.232 seconds] odo dev interactive command tests directory is not empty when there is a match from Alizer should display welcoming messages first /go/odo_1/tests/integration/interactive_dev_test.go:112 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo dev --random-ports' from /tmp/1706501807 << Captured StdOut/StdErr Output ------------------------------ S•SSS•SS•SSS•••SSS•SSSSS•S•SSSSSS•S••SS•SSSS•••S•SSSSS•S••S••SS•••••••SS••SS•••SSSSS••SSSSSS••••S•S•••SSSS•SS•SSSSSS••SS••SSSS•SS•••S••SSS••SS••S•S ------------------------------ • [61.606 seconds] odo dev command tests when a component with multiple endpoints is run should create state files containing information, including forwarded ports /go/odo_1/tests/integration/cmd_dev_test.go:3622 Captured StdOut/StdErr Output >> PID: 26079 << Captured StdOut/StdErr Output ------------------------------ ••••S••S•••SSSS•SSSSSS•S••S••S•SSSSS•SSS•S•S••SSSSSSSSSS••SSSS•SS•SSSSS•SSSS•SS••S••SS•S••S••S•S•••SSSSSSS•SSSS••SS•S•S•SS•SSS••SS••••SSSSSS••S•SS•SS••S•SSSS•SSSSS•SSSSSSSS•S•S•S••S•SSS•S•SSS••S•S•SS•SS•SS••••S•S••SSSS ------------------------------ Progress Report for Ginkgo Process #9 Automatically polling progress: odo dev command tests Devfile contains pod-overrides and container-overrides attributes should override the content in the pod it creates for the component on the cluster (Spec Runtime: 2m2.492s) /go/odo_1/tests/integration/cmd_dev_test.go:4146 In [It] (Node Runtime: 2m0s) /go/odo_1/tests/integration/cmd_dev_test.go:4146 Begin Captured GinkgoWriter Output >> ... [odo] I1023 14:47:41.777504 639 execute_run.go:36] error while running background command: unable to exec command [/bin/sh -c echo $$ > /opt/odo/.odo_cmd_run.pid && cd ${PROJECT_SOURCE} && (npm start) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_run.pid]: error while streaming command: context canceled [odo] ✗ Finished executing the application (command: run) [1m] [odo] I1023 14:47:41.789606 639 implem.go:114] The path for preference file is /tmp/414418920/preference.yaml [odo] I1023 14:47:41.790193 639 segment.go:268] Checking telemetry enable status [odo] I1023 14:47:41.790206 639 segment.go:286] Sending telemetry disabled by env variable [odo] Cleaning resources, please wait [odo] I1023 14:47:41.851048 639 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:47:41.851177 639 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:47:42.758252 639 all.go:67] all goroutines have returned in 907.212497ms [odo] I1023 14:47:42.758328 639 all.go:76] query result: objects=615 << End Captured GinkgoWriter Output Spec Goroutine goroutine 787 [select] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc0003b4cb0, {0x30febe8?, 0xc0016bd3f8}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc0003b4cb0, {0x30febe8, 0xc0016bd3f8}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/onsi/gomega/gexec.(*Session).Wait(0xc000d99d50?, {0xc0006e3b00?, 0x2cf53e9?, 0x9?}) /go/odo_1/vendor/github.com/onsi/gomega/gexec/session.go:144 github.com/redhat-developer/odo/tests/helper.DevSession.WaitEnd(...) /go/odo_1/tests/helper/helper_dev.go:263 github.com/redhat-developer/odo/tests/helper.RunDevMode.func1() /go/odo_1/tests/helper/helper_dev.go:334 github.com/redhat-developer/odo/tests/helper.RunDevMode({{0x0, 0x0, 0x0}, {0x0, 0x0, 0x0}, 0x0, 0x0, 0x0, 0x0, ...}, ...) /go/odo_1/tests/helper/helper_dev.go:337 > github.com/redhat-developer/odo/tests/integration.glob..func7.64.2() /go/odo_1/tests/integration/cmd_dev_test.go:4147 | }) | It("should override the content in the pod it creates for the component on the cluster", func() { > err := helper.RunDevMode(helper.DevSessionOpts{ | RunOnPodman: ctx.podman, | }, func(session *gexec.Session, outContents, _ string, _ map[string]string) { github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0x1088f3e, 0xc00016ae40}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ •••••S ------------------------------ Progress Report for Ginkgo Process #13 Automatically polling progress: odo dev debug command tests when a composite apply command is used as debug command should execute the composite apply commands successfully (Spec Runtime: 3m34.46s) /go/odo_1/tests/integration/cmd_dev_debug_test.go:288 In [It] (Node Runtime: 2m0s) /go/odo_1/tests/integration/cmd_dev_debug_test.go:288 At [By Step] cleaning up the resources on ending the session (Step Runtime: 26.425s) /go/odo_1/tests/integration/cmd_dev_debug_test.go:326 Begin Captured GinkgoWriter Output >> ... [odo] ✗ Finished executing the application (command: start-debug) [1m] [odo] I1023 14:48:06.730633 30470 execute_run.go:36] error while running background command: unable to exec command [/bin/sh -c echo $$ > /opt/odo/.odo_cmd_start-debug.pid && cd /projects && (npm run debug) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_start-debug.pid]: error while streaming command: context canceled [odo] I1023 14:48:06.737578 30470 implem.go:114] The path for preference file is /tmp/939399285/preference.yaml [odo] I1023 14:48:06.738775 30470 segment.go:268] Checking telemetry enable status [odo] I1023 14:48:06.738789 30470 segment.go:286] Sending telemetry disabled by env variable [odo] Cleaning resources, please wait [odo] I1023 14:48:06.844075 30470 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:48:06.848888 30470 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:48:08.225148 30470 all.go:67] all goroutines have returned in 1.381044104s [odo] I1023 14:48:08.225267 30470 all.go:76] query result: objects=652 << End Captured GinkgoWriter Output Spec Goroutine goroutine 31362 [select] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc0005e4930, {0x30febe8?, 0xc0012f8e88}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc0005e4930, {0x30febe8, 0xc0012f8e88}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/onsi/gomega/gexec.(*Session).Wait(0xc0000b16e0?, {0xc0002d2cc0?, 0x0?, 0x0?}) /go/odo_1/vendor/github.com/onsi/gomega/gexec/session.go:144 github.com/redhat-developer/odo/tests/helper.DevSession.WaitEnd(...) /go/odo_1/tests/helper/helper_dev.go:263 > github.com/redhat-developer/odo/tests/integration.glob..func6.7.2.8() /go/odo_1/tests/integration/cmd_dev_debug_test.go:328 | By("cleaning up the resources on ending the session", func() { | devSession.Stop() > devSession.WaitEnd() | out := commonVar.CliRunner.Run("get", "deployments").Out.Contents() | helper.DontMatchAllInOutput(string(out), deploymentNames) github.com/onsi/ginkgo/v2/internal.(*Suite).By(0xc0001a0000, {0x2d5376b, 0x2f}, {0xc000bade70, 0x1, 0x1?}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:309 github.com/onsi/ginkgo/v2.By({0x2d5376b?, 0x0?}, {0xc000bade70?, 0xc000f53ca8?, 0xc0007e6640?}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/core_dsl.go:547 > github.com/redhat-developer/odo/tests/integration.glob..func6.7.2() /go/odo_1/tests/integration/cmd_dev_debug_test.go:326 | }) | > By("cleaning up the resources on ending the session", func() { | devSession.Stop() | devSession.WaitEnd() github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0x1088f25, 0x0}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ •S•SS•SSSS•SSSS••SS•S••S•••••SS•S ------------------------------ Progress Report for Ginkgo Process #6 Automatically polling progress: odo dev command tests checking if odo dev matches local Devfile K8s resources and remote resources when odo dev is executed to run a devfile containing a k8s resource with apply command should have deleted the old resource and created the new resource (Spec Runtime: 2m4.237s) /go/odo_1/tests/integration/cmd_dev_test.go:1077 In [BeforeEach] (Node Runtime: 2m0.001s) /go/odo_1/tests/integration/cmd_dev_test.go:1050 Begin Captured GinkgoWriter Output >> ... [odo] I1023 14:48:48.525926 2499 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 14:48:48.530351 2499 port.go:319] port 8080 not listening in container "runtime" [odo] I1023 14:48:56.176955 2499 exec.go:37] Executing command [/bin/sh -c cat /proc/net/tcp /proc/net/udp /proc/net/tcp6 /proc/net/udp6 || true] for pod: ycuqhp-app-56c7665b6b-mjqzk in container: runtime [odo] I1023 14:48:56.476217 2499 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 14:48:56.476245 2499 exec.go:96] 0: 992B11AC:B7C8 22181068:01BB 06 00000000:00000000 03:00000BFC 00000000 0 0 0 3 0000000000000000 [odo] I1023 14:48:56.476249 2499 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 14:48:56.476254 2499 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 14:48:56.476258 2499 exec.go:96] 0: 00000000000000000000000000000000:0BB8 00000000000000000000000000000000:0000 0A 00000000:00000000 00:00000000 00000000 1016220000 0 1016330809 1 0000000000000000 100 0 0 10 0 [odo] I1023 14:48:56.476261 2499 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 14:48:56.488248 2499 port.go:319] port 8080 not listening in container "runtime" << End Captured GinkgoWriter Output Spec Goroutine goroutine 794 [select, 2 minutes] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc00002acb0, {0x30fee28?, 0xc000f488d0}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc00002acb0, {0x30fee28, 0xc000f488d0}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/redhat-developer/odo/tests/helper.WaitForOutputToContain({0x2cf3614, 0x8}, 0xc0001ec860?, 0xc0001ec820?, 0xc000e97d10) /go/odo_1/tests/helper/helper_run.go:54 github.com/redhat-developer/odo/tests/helper.(*DevSession).WaitSync(0xc0005c0d20) /go/odo_1/tests/helper/helper_dev.go:279 > github.com/redhat-developer/odo/tests/integration.glob..func7.5.1.1() /go/odo_1/tests/integration/cmd_dev_test.go:1069 | helper.ReplaceStrings(filepath.Join(commonVar.Context, "devfile.yaml"), devfile.deploymentName, devfile.newDeploymentName) | > err := devSession.WaitSync() | Expect(err).To(BeNil()) | }) github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0x1088f3e, 0xc000887e00}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ •SSSSSS•SSSSS•SSS••••S•••S•S••S•S••SS•SSSSSSSSSS•SSSS••S•S•SS••• ------------------------------ Progress Report for Ginkgo Process #1 Automatically polling progress: odo dev command tests when a component is bootstrapped ensure that index information is updated (Spec Runtime: 2m4.267s) /go/odo_1/tests/integration/cmd_dev_test.go:305 In [It] (Node Runtime: 2m0s) /go/odo_1/tests/integration/cmd_dev_test.go:305 Begin Captured GinkgoWriter Output >> ... [odo] I1023 14:50:39.884552 5681 watch.go:271] deployment watcher Event: Type: MODIFIED, name: wzcelg-app, rv: 94063503, generation: 1, pods: 1 [odo] I1023 14:50:39.884569 5681 watch.go:333] Dev mode interrupted by user [odo] I1023 14:50:39.890407 5681 implem.go:114] The path for preference file is /tmp/2354938422/preference.yaml [odo] I1023 14:50:39.891442 5681 segment.go:268] Checking telemetry enable status [odo] I1023 14:50:39.891458 5681 segment.go:286] Sending telemetry disabled by env variable [odo] Cleaning resources, please wait [odo] I1023 14:50:40.058062 5681 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:50:40.062254 5681 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:50:41.560963 5681 all.go:67] all goroutines have returned in 1.502923971s [odo] I1023 14:50:41.560991 5681 all.go:76] query result: objects=610 << End Captured GinkgoWriter Output Spec Goroutine goroutine 40208 [select] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc00056d180, {0x30febe8?, 0xc001d2f6c8}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc00056d180, {0x30febe8, 0xc001d2f6c8}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/onsi/gomega/gexec.(*Session).Wait(0xc001353df8?, {0xc0003f1a20?, 0xc002015640?, 0xc00056d110?}) /go/odo_1/vendor/github.com/onsi/gomega/gexec/session.go:144 github.com/redhat-developer/odo/tests/helper.DevSession.WaitEnd(...) /go/odo_1/tests/helper/helper_dev.go:263 github.com/redhat-developer/odo/tests/helper.RunDevMode.func1() /go/odo_1/tests/helper/helper_dev.go:334 github.com/redhat-developer/odo/tests/helper.RunDevMode({{0x0, 0x0, 0x0}, {0x0, 0x0, 0x0}, 0x0, 0x0, 0x0, 0x0, ...}, ...) /go/odo_1/tests/helper/helper_dev.go:337 > github.com/redhat-developer/odo/tests/integration.glob..func7.4.14() /go/odo_1/tests/integration/cmd_dev_test.go:306 | | It("ensure that index information is updated", func() { > err := helper.RunDevMode(helper.DevSessionOpts{}, func(session *gexec.Session, outContents, errContents string, ports map[string]string) { | indexAfterPush, err := util.ReadFileIndex(filepath.Join(commonVar.Context, ".odo", "odo-file-index.json")) | Expect(err).ToNot(HaveOccurred()) github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0x1088f3e, 0xc00038f680}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ •S•SS•S••S•••S•SSS••SSSSSSSSSSS•S•SSSS•••SS•SSSSS•SS•S•SS••S• ------------------------------ • [82.896 seconds] odo dev interactive command tests directory is not empty when there is a match from Alizer should run alizer to download devfile successfully even with -v flag /go/odo_1/tests/integration/interactive_dev_test.go:40 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo dev --random-ports -v 4' from /tmp/2113021961 << Captured StdOut/StdErr Output ------------------------------ SS••••S•S•SSSSS•S••SS•S ------------------------------ • [59.340 seconds] odo dev command with api server tests when the component is bootstrapped when odo dev is run with --api-server flag when /instance endpoint is DELETEd should terminate the dev session /go/odo_1/tests/integration/cmd_dev_api_server_test.go:239 Captured StdOut/StdErr Output >> <<< Session terminated >>> << Captured StdOut/StdErr Output ------------------------------ SSS••••S• ------------------------------ • [3.706 seconds] odo deploy interactive command tests directory is not empty when Alizer cannot determine a Devfile based on the current source code should not fail but fallback to the interactive mode /go/odo_1/tests/integration/interactive_deploy_test.go:159 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo deploy' from /tmp/1196014721 << Captured StdOut/StdErr Output ------------------------------ SSSSS••S•S•••SS•••SSS•SS•S•SS••••••S••S•SS•••S•S•SS•S•S••SS•S••SS•••SSSSSS•SSS ------------------------------ • [24.165 seconds] odo dev interactive command tests when a component is bootstrapped should sync files when p is pressed /go/odo_1/tests/integration/interactive_dev_test.go:209 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo dev --random-ports --no-watch' from /tmp/2973858978 << Captured StdOut/StdErr Output ------------------------------ S•SS•S••S•S•S••S••S••SSSS•SS••••SSS•S•S•SSSSSSS•S•S••SS•SSSS••SSS•SSS•SS•S••SSSSSSSS•SS•S•••••••••••••••• Ran 406 of 956 Specs in 1410.613 seconds SUCCESS! -- 406 Passed | 0 Failed | 0 Pending | 550 Skipped Ginkgo ran 1 suite in 24m39.351559339s Test Suite Passed go run -mod=vendor github.com/onsi/ginkgo/v2/ginkgo --randomize-all --poll-progress-after=120s --poll-progress-interval=120s -timeout 14400s --no-color -nodes=16 --junit-report="test-e2e.xml" tests/e2escenarios Running Suite: odo e2e scenarios - /go/odo_1/tests/e2escenarios =============================================================== Random Seed: 1698073118 - will randomize all specs Will run 4 of 4 specs Running in parallel across 16 processes ------------------------------ • [FAILED] [104.636 seconds] E2E Test starting with non-empty Directory add Binding [It] should verify developer workflow of using binding as env in innerloop /go/odo_1/tests/e2escenarios/e2e_test.go:461 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo init' from /tmp/4016021150 << Captured StdOut/StdErr Output Timeline >> Created dir: /tmp/4016021150 Created dir: /tmp/4095656316 Setting KUBECONFIG=/tmp/4095656316/config Running oc with args [oc get project e2e-test461kue -o jsonpath={.metadata.name}] and odo env: [] [oc] Error from server (NotFound): namespaces "e2e-test461kue" not found Creating a new project: e2e-test461kue Running oc with args [oc new-project e2e-test461kue] and odo env: [] [oc] Now using project "e2e-test461kue" on server "https://c100-e.eu-de.containers.cloud.ibm.com:31952". [oc] [oc] You can add applications to this project with the 'new-app' command. For example, try: [oc] [oc] oc new-app rails-postgresql-example [oc] [oc] to build a new example application in Ruby. Or use kubectl to deploy a simple Kubernetes application: [oc] [oc] kubectl create deployment hello-node --image=k8s.gcr.io/e2e-test-images/agnhost:2.33 -- /agnhost serve-hostname [oc] Running oc with args [oc get project] and odo env: [] [oc] NAME DISPLAY NAME STATUS [oc] calico-system Active [oc] default Active [oc] e2e-test199jfp Active [oc] e2e-test329vyw Active [oc] e2e-test461kue Active [oc] e2e-test63vbj Active [oc] ibm-cert-store Active [oc] ibm-odf-validation-webhook Active [oc] ibm-system Active [oc] kube-node-lease Active [oc] kube-public Active [oc] kube-system Active [oc] laxu-namespace Active [oc] openshift Active [oc] openshift-apiserver Active [oc] openshift-apiserver-operator Active [oc] openshift-authentication Active [oc] openshift-authentication-operator Active [oc] openshift-cloud-credential-operator Active [oc] openshift-cloud-network-config-controller Active [oc] openshift-cluster-csi-drivers Active [oc] openshift-cluster-machine-approver Active [oc] openshift-cluster-node-tuning-operator Active [oc] openshift-cluster-samples-operator Active [oc] openshift-cluster-storage-operator Active [oc] openshift-cluster-version Active [oc] openshift-config Active [oc] openshift-config-managed Active [oc] openshift-config-operator Active [oc] openshift-console Active [oc] openshift-console-operator Active [oc] openshift-console-user-settings Active [oc] openshift-controller-manager Active [oc] openshift-controller-manager-operator Active [oc] openshift-dns Active [oc] openshift-dns-operator Active [oc] openshift-etcd Active [oc] openshift-etcd-operator Active [oc] openshift-image-registry Active [oc] openshift-infra Active [oc] openshift-ingress Active [oc] openshift-ingress-canary Active [oc] openshift-ingress-operator Active [oc] openshift-insights Active [oc] openshift-kube-apiserver Active [oc] openshift-kube-apiserver-operator Active [oc] openshift-kube-controller-manager Active [oc] openshift-kube-controller-manager-operator Active [oc] openshift-kube-proxy Active [oc] openshift-kube-scheduler Active [oc] openshift-kube-scheduler-operator Active [oc] openshift-kube-storage-version-migrator Active [oc] openshift-kube-storage-version-migrator-operator Active [oc] openshift-machine-api Active [oc] openshift-machine-config-operator Active [oc] openshift-marketplace Active [oc] openshift-monitoring Active [oc] openshift-multus Active [oc] openshift-network-diagnostics Active [oc] openshift-network-operator Active [oc] openshift-node Active [oc] openshift-operator-lifecycle-manager Active [oc] openshift-operators Active [oc] openshift-roks-metrics Active [oc] openshift-route-controller-manager Active [oc] openshift-service-ca Active [oc] openshift-service-ca-operator Active [oc] openshift-user-workload-monitoring Active [oc] phmartin Active [oc] tigera-operator Active [oc] ubkm-project Active Running oc with args [oc create configmap config-map-for-cleanup --from-literal type=testing --from-literal team=odo -n e2e-test461kue] and odo env: [] [oc] configmap/config-map-for-cleanup created Current working dir: /go/odo_1/tests/e2escenarios Running odo with args [odo preference remove registry DefaultDevfileRegistry -f] and odo env: [] [odo] I1023 14:58:59.924607 21076 implem.go:114] The path for preference file is /tmp/4095656316/preference.yaml [odo] Successfully removed registry [odo] I1023 14:58:59.931637 21076 implem.go:114] The path for preference file is /tmp/4095656316/preference.yaml [odo] I1023 14:58:59.932222 21076 segment.go:268] Checking telemetry enable status [odo] I1023 14:58:59.932234 21076 segment.go:286] Sending telemetry disabled by env variable Running odo with args [odo preference add registry DefaultDevfileRegistry https://devfile-registry-ci-devfile-registry.odo-test-kubernete-449701-49529fc6e6a4a9fe7ebba9a3db5b55c4-0000.eu-de.containers.appdomain.cloud] and odo env: [] [odo] I1023 14:59:00.197359 21105 implem.go:114] The path for preference file is /tmp/4095656316/preference.yaml [odo] I1023 14:59:00.199141 21105 implem.go:114] The path for preference file is /tmp/4095656316/preference.yaml [odo] New registry successfully added [odo] I1023 14:59:00.199584 21105 segment.go:268] Checking telemetry enable status [odo] I1023 14:59:00.199591 21105 segment.go:286] Sending telemetry disabled by env variable Running oc with args [oc get csv -o jsonpath={.items[?(@.status.phase=="Succeeded")].metadata.name}] and odo env: [] [oc] cloud-native-postgresql.v1.18.7 service-binding-operator.v1.3.3Running oc with args [oc get csv -o jsonpath={.items[?(@.status.phase=="Succeeded")].metadata.name}] and odo env: [] [oc] cloud-native-postgresql.v1.18.7 service-binding-operator.v1.3.3Running oc with args [oc get bindablekinds bindable-kinds -ojsonpath={.status[*].kind}] and odo env: [] [oc] Cluster ServiceBinding ServiceBindingSetting current dir to: /tmp/4016021150 Running oc with args [oc apply -f /go/odo_1/tests/examples/source/devfiles/go/cluster.yaml] and odo env: [] [oc] cluster.postgresql.k8s.enterprisedb.io/cluster-example-initdb created [oc] secret/appuser-secret created [oc] secret/cluster-example-initdb-appuser created running command [odo init] with env [] Running odo with args [odo dev --random-ports --api-server=false] and odo env: [ODO_LOG_LEVEL=4 ODO_TRACKING_CONSENT=no] [odo] I1023 14:59:05.916078 21247 version.go:37] executing [podman version --format json] [odo] I1023 14:59:05.916589 21247 clientset.go:243] no Podman client initialized: exec: "podman": executable file not found in $PATH [odo] I1023 14:59:05.916763 21247 implem.go:114] The path for preference file is /tmp/4095656316/preference.yaml [odo] I1023 14:59:05.918388 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:05.918430 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:05.918979 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:05.919196 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:05.919350 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:05.922545 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:05.924718 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:05.924753 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:05.924915 21247 component.go:87] name of component is "iytjlq", and sanitized name is "iytjlq" [odo] I1023 14:59:05.924950 21247 kclient.go:237] Checking if "projects" resource is supported [odo] __ [odo] / \__ Developing using the "iytjlq" Devfile [odo] \__/ \ Namespace: e2e-test461kue [odo] / \__/ odo version: v3.15.0 (876d43c0d) [odo] \__/ [odo] [odo] ↪ Running on the cluster in Dev mode [odo] I1023 14:59:06.065326 21247 kubedev.go:79] Creating new adapter [odo] I1023 14:59:06.065346 21247 kubedev.go:87] Creating inner-loop resources for the component [odo] I1023 14:59:06.065380 21247 watch.go:105] starting WatchAndPush, path: /tmp/4016021150, component: iytjlq, ignores [.git .odo .odo/odo-file-index.json] [odo] I1023 14:59:06.067846 21247 file_watcher.go:130] adding watch on path /tmp/4016021150 [odo] I1023 14:59:06.067900 21247 file_watcher.go:130] adding watch on path /tmp/4016021150/.odo [odo] I1023 14:59:06.067921 21247 file_watcher.go:130] adding watch on path /tmp/4016021150/middleware [odo] I1023 14:59:06.067934 21247 file_watcher.go:130] adding watch on path /tmp/4016021150/models [odo] I1023 14:59:06.067948 21247 file_watcher.go:130] adding watch on path /tmp/4016021150/router [odo] I1023 14:59:06.083497 21247 watch.go:423] Copying files [] to pod [odo] I1023 14:59:06.083708 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:06.083799 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:06.085433 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:06.085730 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:06.085807 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:06.095424 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:06.095927 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:06.096292 21247 components.go:69] component state: "" [odo] • Waiting for Kubernetes resources ... [odo] I1023 14:59:06.116727 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 14:59:06.155099 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 14:59:06.207929 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 14:59:06.208093 21247 components.go:347] The component name is iytjlq [odo] I1023 14:59:06.211741 21247 kclient.go:286] Kubernetes version is "v1.25.11+1485cc9" [odo] I1023 14:59:06.211845 21247 kclient.go:298] Cluster has support for SSA: true [odo] Warning: would violate PodSecurity "restricted:v1.24": allowPrivilegeEscalation != false (container "runtime" must set securityContext.allowPrivilegeEscalation=false), unrestricted capabilities (container "runtime" must set securityContext.capabilities.drop=["ALL"]), runAsNonRoot != true (pod or container "runtime" must set securityContext.runAsNonRoot=true), seccompProfile (pod or container "runtime" must set securityContext.seccompProfile.type to "RuntimeDefault" or "Localhost") [odo] I1023 14:59:06.332248 21247 components.go:378] Successfully created component iytjlq [odo] I1023 14:59:06.385403 21247 components.go:390] Successfully created Service for component iytjlq [odo] I1023 14:59:06.419482 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:59:06.419983 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:59:06.477205 21247 all.go:67] all goroutines have returned in 57.68643ms [odo] I1023 14:59:06.477356 21247 all.go:76] query result: objects=6 [odo] I1023 14:59:06.477502 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:06.481395 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 14:59:06.485808 21247 service.go:75] Getting list of services [odo] I1023 14:59:06.485914 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 14:59:06.521847 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 14:59:06.521979 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:06.532090 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:06.549096 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:06.560710 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:06.573780 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 14:59:06.573911 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 14:59:06.578132 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:06.583080 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:06.586752 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 14:59:06.596376 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:06.605244 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:06.622745 21247 components.go:134] Deployment has been updated to generation 1. Waiting new event... [odo] I1023 14:59:06.622780 21247 status.go:34] setting inner loop State "WaitDeployment" [odo] =================== [odo] ⚠ Pod is Pending [odo] =================== [odo] I1023 14:59:06.637172 21247 watch.go:271] deployment watcher Event: Type: ADDED, name: iytjlq-app, rv: 94087480, generation: 1, pods: 0 [odo] I1023 14:59:06.639956 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087482, generation: 1, pods: 0 [odo] I1023 14:59:06.641850 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087486, generation: 1, pods: 0 [odo] I1023 14:59:06.643300 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087495, generation: 1, pods: 0 [odo] I1023 14:59:06.940724 21247 watch.go:423] Copying files [] to pod [odo] I1023 14:59:06.941844 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:06.941930 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:06.943389 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:06.943646 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:06.943714 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:06.950638 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:06.950904 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:06.950927 21247 components.go:69] component state: "WaitDeployment" [odo] I1023 14:59:06.964736 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 14:59:07.014284 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 14:59:07.050739 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 14:59:07.050780 21247 components.go:347] The component name is iytjlq [odo] I1023 14:59:07.050796 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 14:59:07.050812 21247 components.go:352] Applying deployment [odo] I1023 14:59:07.094158 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 14:59:07.122956 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 14:59:07.149632 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:59:07.153538 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:59:07.201817 21247 all.go:67] all goroutines have returned in 52.188478ms [odo] I1023 14:59:07.201851 21247 all.go:76] query result: objects=6 [odo] I1023 14:59:07.201894 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:07.201919 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 14:59:07.201934 21247 service.go:75] Getting list of services [odo] I1023 14:59:07.201946 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 14:59:07.235556 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 14:59:07.235665 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:07.247778 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:07.262071 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:07.272720 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:07.283008 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 14:59:07.283047 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 14:59:07.287831 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:07.291088 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:07.295145 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 14:59:07.305974 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:07.315276 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:07.331856 21247 components.go:141] Deployment has 0 ready replicas. Waiting new event... [odo] I1023 14:59:07.331914 21247 status.go:34] setting inner loop State "WaitDeployment" [odo] I1023 14:59:07.332013 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087503, generation: 1, pods: 0 [odo] ✓ Pod is Running [odo] I1023 14:59:23.969094 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087660, generation: 1, pods: 1 [odo] I1023 14:59:24.269362 21247 watch.go:423] Copying files [] to pod [odo] I1023 14:59:24.270593 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:24.270629 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:24.272506 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:24.272751 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:24.272803 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:24.279565 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:24.279971 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:24.280015 21247 components.go:69] component state: "WaitDeployment" [odo] I1023 14:59:24.293546 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 14:59:24.348843 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 14:59:24.388094 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 14:59:24.388122 21247 components.go:347] The component name is iytjlq [odo] I1023 14:59:24.388137 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 14:59:24.388155 21247 components.go:352] Applying deployment [odo] I1023 14:59:24.421764 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 14:59:24.452464 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 14:59:24.481202 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:59:24.481518 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:59:24.551010 21247 all.go:67] all goroutines have returned in 69.803642ms [odo] I1023 14:59:24.551218 21247 all.go:76] query result: objects=6 [odo] I1023 14:59:24.551338 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:24.551404 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 14:59:24.551442 21247 service.go:75] Getting list of services [odo] I1023 14:59:24.551460 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 14:59:24.593544 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 14:59:24.593631 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:24.605194 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:24.618742 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:24.625790 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:24.638019 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 14:59:24.638052 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 14:59:24.641675 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:24.645111 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:24.649523 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 14:59:24.660952 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:24.669771 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] • Syncing files into the container ... [odo] I1023 14:59:24.744236 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150, destBase: ., destFile: . [odo] I1023 14:59:24.744257 21247 file_indexer.go:406] Corrected destinations: base: . file: . [odo] I1023 14:59:24.745621 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.gitignore, destBase: ., destFile: .gitignore [odo] I1023 14:59:24.745662 21247 file_indexer.go:406] Corrected destinations: base: . file: .gitignore [odo] I1023 14:59:24.746070 21247 file_indexer.go:453] file added: /tmp/4016021150/.gitignore [odo] I1023 14:59:24.746103 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.odo, destBase: ., destFile: .odo [odo] I1023 14:59:24.746113 21247 file_indexer.go:406] Corrected destinations: base: . file: .odo [odo] I1023 14:59:24.746447 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/cluster.yaml, destBase: ., destFile: cluster.yaml [odo] I1023 14:59:24.746466 21247 file_indexer.go:406] Corrected destinations: base: . file: cluster.yaml [odo] I1023 14:59:24.746863 21247 file_indexer.go:453] file added: /tmp/4016021150/cluster.yaml [odo] I1023 14:59:24.746899 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/devfile.yaml, destBase: ., destFile: devfile.yaml [odo] I1023 14:59:24.746909 21247 file_indexer.go:406] Corrected destinations: base: . file: devfile.yaml [odo] I1023 14:59:24.747204 21247 file_indexer.go:453] file added: /tmp/4016021150/devfile.yaml [odo] I1023 14:59:24.747232 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.mod, destBase: ., destFile: go.mod [odo] I1023 14:59:24.747243 21247 file_indexer.go:406] Corrected destinations: base: . file: go.mod [odo] I1023 14:59:24.747596 21247 file_indexer.go:453] file added: /tmp/4016021150/go.mod [odo] I1023 14:59:24.747629 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.sum, destBase: ., destFile: go.sum [odo] I1023 14:59:24.747638 21247 file_indexer.go:406] Corrected destinations: base: . file: go.sum [odo] I1023 14:59:24.747931 21247 file_indexer.go:453] file added: /tmp/4016021150/go.sum [odo] I1023 14:59:24.747958 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/main.go, destBase: ., destFile: main.go [odo] I1023 14:59:24.747966 21247 file_indexer.go:406] Corrected destinations: base: . file: main.go [odo] I1023 14:59:24.748291 21247 file_indexer.go:453] file added: /tmp/4016021150/main.go [odo] I1023 14:59:24.748309 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware, destBase: ., destFile: middleware [odo] I1023 14:59:24.748316 21247 file_indexer.go:406] Corrected destinations: base: . file: middleware [odo] I1023 14:59:24.748601 21247 file_indexer.go:453] file added: /tmp/4016021150/middleware [odo] I1023 14:59:24.749133 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware/handlers.go, destBase: ., destFile: middleware/handlers.go [odo] I1023 14:59:24.749152 21247 file_indexer.go:406] Corrected destinations: base: . file: middleware/handlers.go [odo] I1023 14:59:24.749674 21247 file_indexer.go:453] file added: /tmp/4016021150/middleware/handlers.go [odo] I1023 14:59:24.749708 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models, destBase: ., destFile: models [odo] I1023 14:59:24.749743 21247 file_indexer.go:406] Corrected destinations: base: . file: models [odo] I1023 14:59:24.750539 21247 file_indexer.go:453] file added: /tmp/4016021150/models [odo] I1023 14:59:24.751108 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models/models.go, destBase: ., destFile: models/models.go [odo] I1023 14:59:24.751177 21247 file_indexer.go:406] Corrected destinations: base: . file: models/models.go [odo] I1023 14:59:24.751649 21247 file_indexer.go:453] file added: /tmp/4016021150/models/models.go [odo] I1023 14:59:24.751709 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router, destBase: ., destFile: router [odo] I1023 14:59:24.751718 21247 file_indexer.go:406] Corrected destinations: base: . file: router [odo] I1023 14:59:24.752139 21247 file_indexer.go:453] file added: /tmp/4016021150/router [odo] I1023 14:59:24.752594 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router/router.go, destBase: ., destFile: router/router.go [odo] I1023 14:59:24.752631 21247 file_indexer.go:406] Corrected destinations: base: . file: router/router.go [odo] I1023 14:59:24.752982 21247 file_indexer.go:453] file added: /tmp/4016021150/router/router.go [odo] I1023 14:59:24.753554 21247 sync.go:138] List of files to be deleted: +[] [odo] I1023 14:59:24.753575 21247 sync.go:140] List of files changed: +[/tmp/4016021150/go.mod /tmp/4016021150/main.go /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/devfile.yaml /tmp/4016021150/middleware/handlers.go /tmp/4016021150/models/models.go /tmp/4016021150/.gitignore /tmp/4016021150/router/router.go /tmp/4016021150/go.sum /tmp/4016021150/router /tmp/4016021150/cluster.yaml] [odo] I1023 14:59:24.753591 21247 sync.go:193] Push: componentName: iytjlq, path: /tmp/4016021150, files: [/tmp/4016021150/go.mod /tmp/4016021150/main.go /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/devfile.yaml /tmp/4016021150/middleware/handlers.go /tmp/4016021150/models/models.go /tmp/4016021150/.gitignore /tmp/4016021150/router/router.go /tmp/4016021150/go.sum /tmp/4016021150/router /tmp/4016021150/cluster.yaml], delFiles: [*], isForcePush: true [odo] I1023 14:59:24.754246 21247 sync.go:310] remote files marked for deletion are [/projects/*] [odo] I1023 14:59:24.754348 21247 exec.go:37] Executing command [rm -rf /projects/*] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:24.984710 21247 sync.go:233] Copying files /tmp/4016021150/go.mod /tmp/4016021150/main.go /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/devfile.yaml /tmp/4016021150/middleware/handlers.go /tmp/4016021150/models/models.go /tmp/4016021150/.gitignore /tmp/4016021150/router/router.go /tmp/4016021150/go.sum /tmp/4016021150/router /tmp/4016021150/cluster.yaml to pod [odo] I1023 14:59:24.984785 21247 copy.go:36] CopyFile arguments: localPath /tmp/4016021150, dest /projects/4016021150, targetPath /projects, copyFiles [/tmp/4016021150/go.mod /tmp/4016021150/main.go /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/devfile.yaml /tmp/4016021150/middleware/handlers.go /tmp/4016021150/models/models.go /tmp/4016021150/.gitignore /tmp/4016021150/router/router.go /tmp/4016021150/go.sum /tmp/4016021150/router /tmp/4016021150/cluster.yaml], globalExps [.git .odo .odo/odo-file-index.json] [odo] I1023 14:59:24.984863 21247 copy.go:63] Executing command tar xf - -C /projects --no-same-owner [odo] I1023 14:59:24.984958 21247 copy.go:96] makeTar arguments: srcPath: /tmp/4016021150, destPath: /projects/4016021150, files: [/tmp/4016021150/go.mod /tmp/4016021150/main.go /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/devfile.yaml /tmp/4016021150/middleware/handlers.go /tmp/4016021150/models/models.go /tmp/4016021150/.gitignore /tmp/4016021150/router/router.go /tmp/4016021150/go.sum /tmp/4016021150/router /tmp/4016021150/cluster.yaml] [odo] I1023 14:59:24.985316 21247 copy.go:127] Got abs path: /tmp/4016021150/go.mod [odo] I1023 14:59:24.985326 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/go.mod [odo] I1023 14:59:24.985336 21247 copy.go:144] makeTar srcFile: 4016021150/go.mod [odo] I1023 14:59:24.985342 21247 copy.go:145] makeTar destFile: go.mod [odo] I1023 14:59:24.985349 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.mod, destBase: /projects, destFile: go.mod [odo] I1023 14:59:24.985355 21247 copy.go:171] Corrected destinations: base: /projects file: go.mod [odo] I1023 14:59:25.092491 21247 copy.go:127] Got abs path: /tmp/4016021150/main.go [odo] I1023 14:59:25.092627 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/main.go [odo] I1023 14:59:25.092665 21247 copy.go:144] makeTar srcFile: 4016021150/main.go [odo] I1023 14:59:25.092716 21247 copy.go:145] makeTar destFile: main.go [odo] I1023 14:59:25.092757 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/main.go, destBase: /projects, destFile: main.go [odo] I1023 14:59:25.092790 21247 copy.go:171] Corrected destinations: base: /projects file: main.go [odo] I1023 14:59:25.093716 21247 copy.go:127] Got abs path: /tmp/4016021150/middleware [odo] I1023 14:59:25.093774 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/middleware [odo] I1023 14:59:25.093791 21247 copy.go:144] makeTar srcFile: 4016021150/middleware [odo] I1023 14:59:25.093802 21247 copy.go:145] makeTar destFile: middleware [odo] I1023 14:59:25.093842 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware, destBase: /projects, destFile: middleware [odo] I1023 14:59:25.093861 21247 copy.go:171] Corrected destinations: base: /projects file: middleware [odo] I1023 14:59:25.094507 21247 copy.go:127] Got abs path: /tmp/4016021150/models [odo] I1023 14:59:25.094528 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/models [odo] I1023 14:59:25.094541 21247 copy.go:144] makeTar srcFile: 4016021150/models [odo] I1023 14:59:25.094551 21247 copy.go:145] makeTar destFile: models [odo] I1023 14:59:25.094593 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models, destBase: /projects, destFile: models [odo] I1023 14:59:25.094610 21247 copy.go:171] Corrected destinations: base: /projects file: models [odo] I1023 14:59:25.095174 21247 copy.go:127] Got abs path: /tmp/4016021150/devfile.yaml [odo] I1023 14:59:25.095194 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/devfile.yaml [odo] I1023 14:59:25.095207 21247 copy.go:144] makeTar srcFile: 4016021150/devfile.yaml [odo] I1023 14:59:25.095217 21247 copy.go:145] makeTar destFile: devfile.yaml [odo] I1023 14:59:25.095256 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/devfile.yaml, destBase: /projects, destFile: devfile.yaml [odo] I1023 14:59:25.095272 21247 copy.go:171] Corrected destinations: base: /projects file: devfile.yaml [odo] I1023 14:59:25.096049 21247 copy.go:127] Got abs path: /tmp/4016021150/middleware/handlers.go [odo] I1023 14:59:25.096070 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/middleware/handlers.go [odo] I1023 14:59:25.096107 21247 copy.go:144] makeTar srcFile: 4016021150/middleware/handlers.go [odo] I1023 14:59:25.096123 21247 copy.go:145] makeTar destFile: middleware/handlers.go [odo] I1023 14:59:25.096134 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware/handlers.go, destBase: /projects, destFile: middleware/handlers.go [odo] I1023 14:59:25.096150 21247 copy.go:171] Corrected destinations: base: /projects file: middleware/handlers.go [odo] I1023 14:59:25.096997 21247 copy.go:127] Got abs path: /tmp/4016021150/models/models.go [odo] I1023 14:59:25.097017 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/models/models.go [odo] I1023 14:59:25.097030 21247 copy.go:144] makeTar srcFile: 4016021150/models/models.go [odo] I1023 14:59:25.097039 21247 copy.go:145] makeTar destFile: models/models.go [odo] I1023 14:59:25.097048 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models/models.go, destBase: /projects, destFile: models/models.go [odo] I1023 14:59:25.097064 21247 copy.go:171] Corrected destinations: base: /projects file: models/models.go [odo] I1023 14:59:25.097739 21247 copy.go:127] Got abs path: /tmp/4016021150/.gitignore [odo] I1023 14:59:25.097833 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/.gitignore [odo] I1023 14:59:25.097869 21247 copy.go:144] makeTar srcFile: 4016021150/.gitignore [odo] I1023 14:59:25.097916 21247 copy.go:145] makeTar destFile: .gitignore [odo] I1023 14:59:25.097959 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.gitignore, destBase: /projects, destFile: .gitignore [odo] I1023 14:59:25.097988 21247 copy.go:171] Corrected destinations: base: /projects file: .gitignore [odo] I1023 14:59:25.098725 21247 copy.go:127] Got abs path: /tmp/4016021150/router/router.go [odo] I1023 14:59:25.098749 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/router/router.go [odo] I1023 14:59:25.098763 21247 copy.go:144] makeTar srcFile: 4016021150/router/router.go [odo] I1023 14:59:25.098773 21247 copy.go:145] makeTar destFile: router/router.go [odo] I1023 14:59:25.098784 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router/router.go, destBase: /projects, destFile: router/router.go [odo] I1023 14:59:25.098802 21247 copy.go:171] Corrected destinations: base: /projects file: router/router.go [odo] I1023 14:59:25.099345 21247 copy.go:127] Got abs path: /tmp/4016021150/go.sum [odo] I1023 14:59:25.099392 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/go.sum [odo] I1023 14:59:25.099423 21247 copy.go:144] makeTar srcFile: 4016021150/go.sum [odo] I1023 14:59:25.099491 21247 copy.go:145] makeTar destFile: go.sum [odo] I1023 14:59:25.099532 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.sum, destBase: /projects, destFile: go.sum [odo] I1023 14:59:25.099573 21247 copy.go:171] Corrected destinations: base: /projects file: go.sum [odo] I1023 14:59:25.100255 21247 copy.go:127] Got abs path: /tmp/4016021150/router [odo] I1023 14:59:25.100279 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/router [odo] I1023 14:59:25.100296 21247 copy.go:144] makeTar srcFile: 4016021150/router [odo] I1023 14:59:25.100305 21247 copy.go:145] makeTar destFile: router [odo] I1023 14:59:25.100315 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router, destBase: /projects, destFile: router [odo] I1023 14:59:25.100330 21247 copy.go:171] Corrected destinations: base: /projects file: router [odo] I1023 14:59:25.100788 21247 copy.go:127] Got abs path: /tmp/4016021150/cluster.yaml [odo] I1023 14:59:25.100811 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/cluster.yaml [odo] I1023 14:59:25.100824 21247 copy.go:144] makeTar srcFile: 4016021150/cluster.yaml [odo] I1023 14:59:25.100833 21247 copy.go:145] makeTar destFile: cluster.yaml [odo] I1023 14:59:25.100848 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/cluster.yaml, destBase: /projects, destFile: cluster.yaml [odo] I1023 14:59:25.100856 21247 copy.go:171] Corrected destinations: base: /projects file: cluster.yaml [odo] ✓ Syncing files into the container [444ms] [odo] I1023 14:59:25.190637 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 14:59:25.190687 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:25.417427 21247 exec.go:96] cat: /opt/odo/.odo_cmd_run.pid: No such file or directory [odo] I1023 14:59:25.418156 21247 innerloop.go:131] running=false, execRequired=true [odo] • Building your application in container (command: build) ... [odo] I1023 14:59:25.418627 21247 exec.go:37] Executing command [/bin/sh -c cd ${PROJECT_SOURCE} && (export GOPATH="${PROJECT_SOURCE}/.go" GOCACHE="${PROJECT_SOURCE}/.cache" && go build main.go) 1>>/proc/1/fd/1 2>>/proc/1/fd/2] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:27.974868 21247 kubeexec.go:54] StartProcessForCommand for "run" [odo] I1023 14:59:27.974943 21247 retry.go:48] waiting for 5 second(s) before trying task "process for command \"run\"" [odo] ✓ Building your application in container (command: build) [3s] [odo] • Executing the application (command: run) ... [odo] I1023 14:59:27.974969 21247 exec.go:37] Executing command [/bin/sh -c echo $$ > /opt/odo/.odo_cmd_run.pid && cd ${PROJECT_SOURCE} && (./main) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_run.pid] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:32.976024 21247 execute_run.go:90] checking if process for command "run" is running [odo] I1023 14:59:32.976070 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 14:59:32.976105 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:33.721817 21247 exec.go:96] 161 [odo] I1023 14:59:33.724415 21247 exec.go:37] Executing command [/bin/sh -c kill -0 161; echo $?] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:34.027635 21247 exec.go:96] 0 [odo] I1023 14:59:34.028244 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 14:59:34.028334 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:34.354748 21247 exec.go:96] 161 [odo] I1023 14:59:34.357595 21247 exec.go:37] Executing command [/bin/sh -c kill -0 161; echo $?] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:34.703997 21247 exec.go:96] 0 [odo] • Waiting for the application to be ready ... [odo] I1023 14:59:35.705536 21247 exec.go:37] Executing command [/bin/sh -c cat /proc/net/tcp /proc/net/udp /proc/net/tcp6 /proc/net/udp6 || true] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 14:59:35.882690 21247 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 14:59:35.882861 21247 exec.go:96] 0: 8F2B11AC:B2CA D110D9AC:01BB 06 00000000:00000000 03:00001459 00000000 0 0 0 3 0000000000000000 [odo] I1023 14:59:35.882943 21247 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 14:59:35.883029 21247 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 14:59:35.883069 21247 exec.go:96] 0: 00000000000000000000000000000000:1F90 00000000000000000000000000000000:0000 0A 00000000:00000000 00:00000000 00000000 1018860000 0 1016628459 1 0000000000000000 100 0 0 10 0 [odo] I1023 14:59:35.883163 21247 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 14:59:35.887529 21247 port.go:346] ports not listening: map[] [odo] ✓ Waiting for the application to be ready [1s] [odo] - Forwarding from 127.0.0.1:34941 -> 8080 [odo] [odo] I1023 14:59:35.980174 21247 status.go:34] setting inner loop State "Ready" [odo] [odo] ↪ Dev mode [odo] Status: [odo] Watching for changes in the current directory /tmp/4016021150 [odo] [odo] Keyboard Commands: [odo] [Ctrl+c] - Exit and delete resources from the cluster [odo] [p] - Manually apply local changes to the application on the cluster [odo] I1023 14:59:35.980269 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087661, generation: 1, pods: 1 [odo] I1023 14:59:36.082004 21247 watch.go:348] filesystem watch event: CREATE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 14:59:36.083179 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 14:59:36.083633 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.json" [odo] I1023 14:59:36.084113 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.21247.json" Running odo with args [odo add binding --name uidgcf --service cluster-example-initdb --bind-as-files=false] and odo env: [] [odo] I1023 14:59:46.983998 21333 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:46.984882 21333 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:46.985924 21333 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:46.986037 21333 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:46.986229 21333 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:46.991383 21333 schema.go:61] validated devfile schema [odo] I1023 14:59:46.993679 21333 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:46.993703 21333 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:46.993886 21333 component.go:87] name of component is "iytjlq", and sanitized name is "iytjlq" [odo] I1023 14:59:46.993917 21333 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:47.125490 21333 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:47.125512 21333 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:47.126126 21333 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:47.126189 21333 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:47.126201 21333 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:47.129287 21333 schema.go:61] validated devfile schema [odo] I1023 14:59:47.129503 21333 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:47.333652 21333 kclient.go:237] Checking if "deployments" resource is supported [odo] I1023 14:59:47.342457 21333 writer.go:55] devfile yaml created at: 'devfile.yaml' [odo] ✓ Successfully added the binding to the devfile. [odo] Run `odo dev` to create it on the cluster. [odo] I1023 14:59:47.342612 21333 implem.go:114] The path for preference file is /tmp/4095656316/preference.yaml [odo] I1023 14:59:47.343852 21333 segment.go:268] Checking telemetry enable status [odo] I1023 14:59:47.343942 21333 segment.go:286] Sending telemetry disabled by env variable [odo] I1023 14:59:47.443843 21247 watch.go:348] filesystem watch event: CREATE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 14:59:47.444760 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 14:59:47.445092 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.json" [odo] I1023 14:59:47.445574 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.21247.json" [odo] I1023 14:59:47.446055 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/devfile.yaml" [odo] I1023 14:59:47.447426 21247 file_watcher.go:64] adding watch on path /tmp/4016021150/devfile.yaml [odo] I1023 14:59:47.447801 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/devfile.yaml" [odo] I1023 14:59:47.448461 21247 file_watcher.go:64] adding watch on path /tmp/4016021150/devfile.yaml [odo] I1023 14:59:47.448496 21247 status.go:34] setting inner loop State "SyncOutdated" [odo] Pushing files... [odo] [odo] [odo] File /tmp/4016021150/devfile.yaml changed [odo] I1023 14:59:47.448580 21247 watch.go:423] Copying files [/tmp/4016021150/devfile.yaml] to pod [odo] I1023 14:59:47.448861 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:47.448883 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:47.450735 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:47.450983 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:47.451051 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:47.459062 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:47.459620 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:47.459690 21247 components.go:69] component state: "SyncOutdated" [odo] • Waiting for Kubernetes resources ... [odo] I1023 14:59:47.472087 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 14:59:47.514667 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 14:59:47.555251 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 14:59:47.555353 21247 components.go:347] The component name is iytjlq [odo] I1023 14:59:47.555372 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 14:59:47.555394 21247 components.go:352] Applying deployment [odo] I1023 14:59:47.593025 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 14:59:47.624663 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 14:59:47.648649 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:59:47.648905 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:59:47.699505 21247 all.go:67] all goroutines have returned in 50.874579ms [odo] I1023 14:59:47.699599 21247 all.go:76] query result: objects=7 [odo] I1023 14:59:47.700463 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:47.748936 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 14:59:47.749036 21247 service.go:75] Getting list of services [odo] I1023 14:59:47.749064 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 14:59:47.776349 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 14:59:47.776414 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:47.785058 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:47.796975 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:47.806378 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:47.815408 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 14:59:47.815438 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 14:59:47.819175 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:47.823625 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:47.826263 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 14:59:47.834826 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:47.847130 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:47.854143 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] • Creating resource ServiceBinding/uidgcf ... [odo] ✓ Creating resource ServiceBinding/uidgcf [odo] I1023 14:59:48.017370 21247 components.go:152] Waiting for all service bindings to be injected... [odo] I1023 14:59:48.017624 21247 watch.go:437] Error from Push: watch command was unable to push component: some servicebindings are not injected [odo] Error occurred on Push - watch command was unable to push component: some servicebindings are not injected [odo] [odo] [odo] ↪ Dev mode [odo] Status: [odo] Watching for changes in the current directory /tmp/4016021150 [odo] [odo] Keyboard Commands: [odo] [Ctrl+c] - Exit and delete resources from the cluster [odo] [p] - Manually apply local changes to the application on the cluster [odo] Updating Component... [odo] [odo] I1023 14:59:48.017803 21247 watch.go:423] Copying files [] to pod [odo] I1023 14:59:48.018724 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:48.018760 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:48.019986 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:48.020109 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:48.020136 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:48.026262 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:48.026635 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:48.026681 21247 components.go:69] component state: "SyncOutdated" [odo] • Waiting for Kubernetes resources ... [odo] I1023 14:59:48.045054 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 14:59:48.089270 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 14:59:48.122505 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 14:59:48.122540 21247 components.go:347] The component name is iytjlq [odo] I1023 14:59:48.122556 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 14:59:48.122572 21247 components.go:352] Applying deployment [odo] I1023 14:59:48.157489 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 14:59:48.186649 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 14:59:48.210859 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:59:48.210958 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:59:48.270712 21247 all.go:67] all goroutines have returned in 59.845305ms [odo] I1023 14:59:48.270771 21247 all.go:76] query result: objects=8 [odo] I1023 14:59:48.271783 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:48.272656 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 14:59:48.272687 21247 service.go:75] Getting list of services [odo] I1023 14:59:48.272697 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 14:59:48.313352 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 14:59:48.313396 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:48.324308 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:48.338182 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:48.346984 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:48.357043 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 14:59:48.357115 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 14:59:48.360928 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:48.365690 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:48.369179 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 14:59:48.382635 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:48.393889 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:48.402460 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:48.586620 21247 watch.go:437] Error from Push: watch command was unable to push component: unable to get pod for component iytjlq: pod not found for the selector: component=iytjlq [odo] Error occurred on Push - watch command was unable to push component: unable to get pod for component iytjlq: pod not found for the selector: component=iytjlq [odo] [odo] [odo] ↪ Dev mode [odo] Status: [odo] Watching for changes in the current directory /tmp/4016021150 [odo] [odo] Keyboard Commands: [odo] [Ctrl+c] - Exit and delete resources from the cluster [odo] [p] - Manually apply local changes to the application on the cluster [odo] I1023 14:59:48.586856 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087830, generation: 1, pods: 1 [odo] ======================= [odo] ⚠ Pod is Terminating [odo] ======================= [odo] I1023 14:59:48.588216 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087839, generation: 1, pods: 1 [odo] I1023 14:59:48.589257 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087841, generation: 2, pods: 1 [odo] I1023 14:59:48.590431 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087845, generation: 2, pods: 1 [odo] I1023 14:59:48.591396 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087853, generation: 2, pods: 0 [odo] I1023 14:59:48.892536 21247 watch.go:423] Copying files [] to pod [odo] I1023 14:59:48.893034 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:48.893065 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 14:59:48.894995 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 14:59:48.895268 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 14:59:48.895333 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 14:59:48.901682 21247 schema.go:61] validated devfile schema [odo] I1023 14:59:48.902195 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 14:59:48.902269 21247 components.go:69] component state: "SyncOutdated" [odo] • Waiting for Kubernetes resources ... [odo] I1023 14:59:48.915223 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 14:59:48.956347 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 14:59:48.992623 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 14:59:48.992749 21247 components.go:347] The component name is iytjlq [odo] I1023 14:59:48.992787 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 14:59:48.992845 21247 components.go:352] Applying deployment [odo] I1023 14:59:49.039694 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 14:59:49.074792 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 14:59:49.101809 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 14:59:49.103484 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 14:59:49.168401 21247 all.go:67] all goroutines have returned in 66.577926ms [odo] I1023 14:59:49.168511 21247 all.go:76] query result: objects=8 [odo] I1023 14:59:49.169308 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:49.170136 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 14:59:49.170178 21247 service.go:75] Getting list of services [odo] I1023 14:59:49.170197 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 14:59:49.202924 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 14:59:49.202956 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:49.211870 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:49.226530 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:49.236041 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 14:59:49.247190 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 14:59:49.247208 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 14:59:49.251237 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:49.255619 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 14:59:49.259309 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 14:59:49.276139 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:49.286169 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 14:59:49.297136 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 14:59:49.375259 21247 components.go:141] Deployment has 0 ready replicas. Waiting new event... [odo] I1023 14:59:49.375300 21247 status.go:34] setting inner loop State "WaitDeployment" [odo] I1023 14:59:49.375363 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94087861, generation: 2, pods: 0 [odo] I1023 15:00:18.482675 21247 exec.go:54] ExecuteCommand returned an an err: error while streaming command: command terminated with exit code 137. for command '[/bin/sh -c echo $$ > /opt/odo/.odo_cmd_run.pid && cd ${PROJECT_SOURCE} && (./main) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_run.pid]' [odo] stdout: [] [odo] stderr: [] [odo] I1023 15:00:18.482763 21247 kubeexec.go:118] error while running background command: unable to exec command [/bin/sh -c echo $$ > /opt/odo/.odo_cmd_run.pid && cd ${PROJECT_SOURCE} && (./main) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_run.pid]: error while streaming command: command terminated with exit code 137 [odo] I1023 15:00:18.482791 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 15:00:18.482854 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-785fdb8dff-qvhtq in container: runtime [odo] I1023 15:00:18.651640 21247 exec.go:54] ExecuteCommand returned an an err: error while streaming command: Internal error occurred: error executing command in container: container is not created or running. for command '[/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true]' [odo] stdout: [] [odo] stderr: [] [odo] ✗ Finished executing the application (command: run) [51s] [odo] I1023 15:00:18.651808 21247 execute_run.go:36] error while running background command: unable to exec command [/bin/sh -c echo $$ > /opt/odo/.odo_cmd_run.pid && cd ${PROJECT_SOURCE} && (./main) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_run.pid]: error while streaming command: command terminated with exit code 137 [odo] ================== [odo] ⚠ No pod exists [odo] ================== [odo] I1023 15:00:20.269957 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94088160, generation: 2, pods: 0 [odo] =================== [odo] ⚠ Pod is Pending [odo] =================== [odo] I1023 15:00:20.310735 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94088162, generation: 2, pods: 0 [odo] I1023 15:00:20.365782 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94088168, generation: 2, pods: 0 [odo] ✓ Pod is Running [odo] I1023 15:00:22.211501 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94088198, generation: 2, pods: 1 [odo] I1023 15:00:22.512327 21247 watch.go:423] Copying files [] to pod [odo] I1023 15:00:22.513852 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 15:00:22.513923 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 15:00:22.515624 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 15:00:22.515872 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 15:00:22.515967 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 15:00:22.521640 21247 schema.go:61] validated devfile schema [odo] I1023 15:00:22.522208 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 15:00:22.522318 21247 components.go:69] component state: "WaitDeployment" [odo] I1023 15:00:22.545422 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 15:00:22.598984 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 15:00:22.671127 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 15:00:22.671278 21247 components.go:347] The component name is iytjlq [odo] I1023 15:00:22.671317 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 15:00:22.671373 21247 components.go:352] Applying deployment [odo] I1023 15:00:22.749318 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 15:00:22.787772 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 15:00:22.824924 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 15:00:22.825256 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 15:00:23.344289 21247 all.go:67] all goroutines have returned in 519.347334ms [odo] I1023 15:00:23.344343 21247 all.go:76] query result: objects=8 [odo] I1023 15:00:23.345358 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 15:00:23.346339 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 15:00:23.346853 21247 service.go:75] Getting list of services [odo] I1023 15:00:23.346876 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 15:00:23.377345 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 15:00:23.377398 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:23.387951 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:23.405892 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:23.420032 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:23.431973 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 15:00:23.432031 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 15:00:23.435593 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 15:00:23.439299 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 15:00:23.442857 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 15:00:23.454155 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 15:00:23.463783 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 15:00:23.474230 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] • Syncing files into the container ... [odo] I1023 15:00:23.604491 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150, destBase: ., destFile: . [odo] I1023 15:00:23.604549 21247 file_indexer.go:406] Corrected destinations: base: . file: . [odo] I1023 15:00:23.606227 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.gitignore, destBase: ., destFile: .gitignore [odo] I1023 15:00:23.606258 21247 file_indexer.go:406] Corrected destinations: base: . file: .gitignore [odo] I1023 15:00:23.606639 21247 file_indexer.go:453] file added: /tmp/4016021150/.gitignore [odo] I1023 15:00:23.606679 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.odo, destBase: ., destFile: .odo [odo] I1023 15:00:23.606688 21247 file_indexer.go:406] Corrected destinations: base: . file: .odo [odo] I1023 15:00:23.606997 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/cluster.yaml, destBase: ., destFile: cluster.yaml [odo] I1023 15:00:23.607019 21247 file_indexer.go:406] Corrected destinations: base: . file: cluster.yaml [odo] I1023 15:00:23.607354 21247 file_indexer.go:453] file added: /tmp/4016021150/cluster.yaml [odo] I1023 15:00:23.607388 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/devfile.yaml, destBase: ., destFile: devfile.yaml [odo] I1023 15:00:23.607397 21247 file_indexer.go:406] Corrected destinations: base: . file: devfile.yaml [odo] I1023 15:00:23.607687 21247 file_indexer.go:453] file added: /tmp/4016021150/devfile.yaml [odo] I1023 15:00:23.607721 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.mod, destBase: ., destFile: go.mod [odo] I1023 15:00:23.607729 21247 file_indexer.go:406] Corrected destinations: base: . file: go.mod [odo] I1023 15:00:23.608043 21247 file_indexer.go:453] file added: /tmp/4016021150/go.mod [odo] I1023 15:00:23.608114 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.sum, destBase: ., destFile: go.sum [odo] I1023 15:00:23.608135 21247 file_indexer.go:406] Corrected destinations: base: . file: go.sum [odo] I1023 15:00:23.608422 21247 file_indexer.go:453] file added: /tmp/4016021150/go.sum [odo] I1023 15:00:23.608452 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/main.go, destBase: ., destFile: main.go [odo] I1023 15:00:23.608459 21247 file_indexer.go:406] Corrected destinations: base: . file: main.go [odo] I1023 15:00:23.608819 21247 file_indexer.go:453] file added: /tmp/4016021150/main.go [odo] I1023 15:00:23.608854 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware, destBase: ., destFile: middleware [odo] I1023 15:00:23.608862 21247 file_indexer.go:406] Corrected destinations: base: . file: middleware [odo] I1023 15:00:23.609141 21247 file_indexer.go:453] file added: /tmp/4016021150/middleware [odo] I1023 15:00:23.609725 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware/handlers.go, destBase: ., destFile: middleware/handlers.go [odo] I1023 15:00:23.609744 21247 file_indexer.go:406] Corrected destinations: base: . file: middleware/handlers.go [odo] I1023 15:00:23.610055 21247 file_indexer.go:453] file added: /tmp/4016021150/middleware/handlers.go [odo] I1023 15:00:23.610120 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models, destBase: ., destFile: models [odo] I1023 15:00:23.610139 21247 file_indexer.go:406] Corrected destinations: base: . file: models [odo] I1023 15:00:23.610546 21247 file_indexer.go:453] file added: /tmp/4016021150/models [odo] I1023 15:00:23.610982 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models/models.go, destBase: ., destFile: models/models.go [odo] I1023 15:00:23.610999 21247 file_indexer.go:406] Corrected destinations: base: . file: models/models.go [odo] I1023 15:00:23.611260 21247 file_indexer.go:453] file added: /tmp/4016021150/models/models.go [odo] I1023 15:00:23.611297 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router, destBase: ., destFile: router [odo] I1023 15:00:23.611305 21247 file_indexer.go:406] Corrected destinations: base: . file: router [odo] I1023 15:00:23.611608 21247 file_indexer.go:453] file added: /tmp/4016021150/router [odo] I1023 15:00:23.612065 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router/router.go, destBase: ., destFile: router/router.go [odo] I1023 15:00:23.612082 21247 file_indexer.go:406] Corrected destinations: base: . file: router/router.go [odo] I1023 15:00:23.612340 21247 file_indexer.go:453] file added: /tmp/4016021150/router/router.go [odo] I1023 15:00:23.612634 21247 sync.go:138] List of files to be deleted: +[] [odo] I1023 15:00:23.612656 21247 sync.go:140] List of files changed: +[/tmp/4016021150/devfile.yaml /tmp/4016021150/router/router.go /tmp/4016021150/go.mod /tmp/4016021150/go.sum /tmp/4016021150/middleware/handlers.go /tmp/4016021150/.gitignore /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/cluster.yaml /tmp/4016021150/models/models.go /tmp/4016021150/router /tmp/4016021150/main.go] [odo] I1023 15:00:23.612672 21247 sync.go:193] Push: componentName: iytjlq, path: /tmp/4016021150, files: [/tmp/4016021150/devfile.yaml /tmp/4016021150/router/router.go /tmp/4016021150/go.mod /tmp/4016021150/go.sum /tmp/4016021150/middleware/handlers.go /tmp/4016021150/.gitignore /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/cluster.yaml /tmp/4016021150/models/models.go /tmp/4016021150/router /tmp/4016021150/main.go], delFiles: [*], isForcePush: true [odo] I1023 15:00:23.613208 21247 sync.go:310] remote files marked for deletion are [/projects/*] [odo] I1023 15:00:23.613241 21247 exec.go:37] Executing command [rm -rf /projects/*] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:23.797986 21247 sync.go:233] Copying files /tmp/4016021150/devfile.yaml /tmp/4016021150/router/router.go /tmp/4016021150/go.mod /tmp/4016021150/go.sum /tmp/4016021150/middleware/handlers.go /tmp/4016021150/.gitignore /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/cluster.yaml /tmp/4016021150/models/models.go /tmp/4016021150/router /tmp/4016021150/main.go to pod [odo] I1023 15:00:23.798109 21247 copy.go:36] CopyFile arguments: localPath /tmp/4016021150, dest /projects/4016021150, targetPath /projects, copyFiles [/tmp/4016021150/devfile.yaml /tmp/4016021150/router/router.go /tmp/4016021150/go.mod /tmp/4016021150/go.sum /tmp/4016021150/middleware/handlers.go /tmp/4016021150/.gitignore /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/cluster.yaml /tmp/4016021150/models/models.go /tmp/4016021150/router /tmp/4016021150/main.go], globalExps [.git .odo .odo/odo-file-index.json] [odo] I1023 15:00:23.798204 21247 copy.go:63] Executing command tar xf - -C /projects --no-same-owner [odo] I1023 15:00:23.798310 21247 copy.go:96] makeTar arguments: srcPath: /tmp/4016021150, destPath: /projects/4016021150, files: [/tmp/4016021150/devfile.yaml /tmp/4016021150/router/router.go /tmp/4016021150/go.mod /tmp/4016021150/go.sum /tmp/4016021150/middleware/handlers.go /tmp/4016021150/.gitignore /tmp/4016021150/middleware /tmp/4016021150/models /tmp/4016021150/cluster.yaml /tmp/4016021150/models/models.go /tmp/4016021150/router /tmp/4016021150/main.go] [odo] I1023 15:00:23.798813 21247 copy.go:127] Got abs path: /tmp/4016021150/devfile.yaml [odo] I1023 15:00:23.798838 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/devfile.yaml [odo] I1023 15:00:23.798854 21247 copy.go:144] makeTar srcFile: 4016021150/devfile.yaml [odo] I1023 15:00:23.798863 21247 copy.go:145] makeTar destFile: devfile.yaml [odo] I1023 15:00:23.798873 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/devfile.yaml, destBase: /projects, destFile: devfile.yaml [odo] I1023 15:00:23.798882 21247 copy.go:171] Corrected destinations: base: /projects file: devfile.yaml [odo] I1023 15:00:23.929217 21247 copy.go:127] Got abs path: /tmp/4016021150/router/router.go [odo] I1023 15:00:23.929262 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/router/router.go [odo] I1023 15:00:23.929278 21247 copy.go:144] makeTar srcFile: 4016021150/router/router.go [odo] I1023 15:00:23.929288 21247 copy.go:145] makeTar destFile: router/router.go [odo] I1023 15:00:23.929297 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router/router.go, destBase: /projects, destFile: router/router.go [odo] I1023 15:00:23.929311 21247 copy.go:171] Corrected destinations: base: /projects file: router/router.go [odo] I1023 15:00:23.930231 21247 copy.go:127] Got abs path: /tmp/4016021150/go.mod [odo] I1023 15:00:23.930295 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/go.mod [odo] I1023 15:00:23.930330 21247 copy.go:144] makeTar srcFile: 4016021150/go.mod [odo] I1023 15:00:23.930367 21247 copy.go:145] makeTar destFile: go.mod [odo] I1023 15:00:23.930395 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.mod, destBase: /projects, destFile: go.mod [odo] I1023 15:00:23.930422 21247 copy.go:171] Corrected destinations: base: /projects file: go.mod [odo] I1023 15:00:23.931231 21247 copy.go:127] Got abs path: /tmp/4016021150/go.sum [odo] I1023 15:00:23.931290 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/go.sum [odo] I1023 15:00:23.931322 21247 copy.go:144] makeTar srcFile: 4016021150/go.sum [odo] I1023 15:00:23.931353 21247 copy.go:145] makeTar destFile: go.sum [odo] I1023 15:00:23.931380 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.sum, destBase: /projects, destFile: go.sum [odo] I1023 15:00:23.931436 21247 copy.go:171] Corrected destinations: base: /projects file: go.sum [odo] I1023 15:00:23.932120 21247 copy.go:127] Got abs path: /tmp/4016021150/middleware/handlers.go [odo] I1023 15:00:23.932173 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/middleware/handlers.go [odo] I1023 15:00:23.932203 21247 copy.go:144] makeTar srcFile: 4016021150/middleware/handlers.go [odo] I1023 15:00:23.932229 21247 copy.go:145] makeTar destFile: middleware/handlers.go [odo] I1023 15:00:23.932263 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware/handlers.go, destBase: /projects, destFile: middleware/handlers.go [odo] I1023 15:00:23.932290 21247 copy.go:171] Corrected destinations: base: /projects file: middleware/handlers.go [odo] I1023 15:00:23.936448 21247 copy.go:127] Got abs path: /tmp/4016021150/.gitignore [odo] I1023 15:00:23.936483 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/.gitignore [odo] I1023 15:00:23.936545 21247 copy.go:144] makeTar srcFile: 4016021150/.gitignore [odo] I1023 15:00:23.936563 21247 copy.go:145] makeTar destFile: .gitignore [odo] I1023 15:00:23.936605 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.gitignore, destBase: /projects, destFile: .gitignore [odo] I1023 15:00:23.936622 21247 copy.go:171] Corrected destinations: base: /projects file: .gitignore [odo] I1023 15:00:23.942367 21247 copy.go:127] Got abs path: /tmp/4016021150/middleware [odo] I1023 15:00:23.942393 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/middleware [odo] I1023 15:00:23.942424 21247 copy.go:144] makeTar srcFile: 4016021150/middleware [odo] I1023 15:00:23.942438 21247 copy.go:145] makeTar destFile: middleware [odo] I1023 15:00:23.942446 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware, destBase: /projects, destFile: middleware [odo] I1023 15:00:23.942457 21247 copy.go:171] Corrected destinations: base: /projects file: middleware [odo] I1023 15:00:23.942901 21247 copy.go:127] Got abs path: /tmp/4016021150/models [odo] I1023 15:00:23.942939 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/models [odo] I1023 15:00:23.942953 21247 copy.go:144] makeTar srcFile: 4016021150/models [odo] I1023 15:00:23.942960 21247 copy.go:145] makeTar destFile: models [odo] I1023 15:00:23.942970 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models, destBase: /projects, destFile: models [odo] I1023 15:00:23.942976 21247 copy.go:171] Corrected destinations: base: /projects file: models [odo] I1023 15:00:23.943313 21247 copy.go:127] Got abs path: /tmp/4016021150/cluster.yaml [odo] I1023 15:00:23.943329 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/cluster.yaml [odo] I1023 15:00:23.943362 21247 copy.go:144] makeTar srcFile: 4016021150/cluster.yaml [odo] I1023 15:00:23.943370 21247 copy.go:145] makeTar destFile: cluster.yaml [odo] I1023 15:00:23.943383 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/cluster.yaml, destBase: /projects, destFile: cluster.yaml [odo] I1023 15:00:23.943393 21247 copy.go:171] Corrected destinations: base: /projects file: cluster.yaml [odo] I1023 15:00:23.943934 21247 copy.go:127] Got abs path: /tmp/4016021150/models/models.go [odo] I1023 15:00:23.943950 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/models/models.go [odo] I1023 15:00:23.943977 21247 copy.go:144] makeTar srcFile: 4016021150/models/models.go [odo] I1023 15:00:23.943992 21247 copy.go:145] makeTar destFile: models/models.go [odo] I1023 15:00:23.944011 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models/models.go, destBase: /projects, destFile: models/models.go [odo] I1023 15:00:23.944021 21247 copy.go:171] Corrected destinations: base: /projects file: models/models.go [odo] I1023 15:00:23.944953 21247 copy.go:127] Got abs path: /tmp/4016021150/router [odo] I1023 15:00:23.945003 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/router [odo] I1023 15:00:23.945024 21247 copy.go:144] makeTar srcFile: 4016021150/router [odo] I1023 15:00:23.945042 21247 copy.go:145] makeTar destFile: router [odo] I1023 15:00:23.945059 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router, destBase: /projects, destFile: router [odo] I1023 15:00:23.945077 21247 copy.go:171] Corrected destinations: base: /projects file: router [odo] I1023 15:00:23.945488 21247 copy.go:127] Got abs path: /tmp/4016021150/main.go [odo] I1023 15:00:23.945520 21247 copy.go:128] Making /tmp/4016021150 relative to /tmp/4016021150/main.go [odo] I1023 15:00:23.945540 21247 copy.go:144] makeTar srcFile: 4016021150/main.go [odo] I1023 15:00:23.945556 21247 copy.go:145] makeTar destFile: main.go [odo] I1023 15:00:23.945572 21247 copy.go:165] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/main.go, destBase: /projects, destFile: main.go [odo] I1023 15:00:23.945589 21247 copy.go:171] Corrected destinations: base: /projects file: main.go [odo] ✓ Syncing files into the container [411ms] [odo] I1023 15:00:24.018204 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 15:00:24.018304 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:24.198371 21247 exec.go:96] cat: /opt/odo/.odo_cmd_run.pid: No such file or directory [odo] I1023 15:00:24.199937 21247 innerloop.go:131] running=false, execRequired=true [odo] • Building your application in container (command: build) ... [odo] I1023 15:00:24.200261 21247 exec.go:37] Executing command [/bin/sh -c cd ${PROJECT_SOURCE} && (export GOPATH="${PROJECT_SOURCE}/.go" GOCACHE="${PROJECT_SOURCE}/.cache" && go build main.go) 1>>/proc/1/fd/1 2>>/proc/1/fd/2] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] ✓ Building your application in container (command: build) [2s] [odo] • Executing the application (command: run) ... [odo] I1023 15:00:26.605515 21247 kubeexec.go:54] StartProcessForCommand for "run" [odo] I1023 15:00:26.605580 21247 retry.go:48] waiting for 5 second(s) before trying task "process for command \"run\"" [odo] I1023 15:00:26.605603 21247 exec.go:37] Executing command [/bin/sh -c echo $$ > /opt/odo/.odo_cmd_run.pid && cd ${PROJECT_SOURCE} && (./main) 1>>/proc/1/fd/1 2>>/proc/1/fd/2; echo $? >> /opt/odo/.odo_cmd_run.pid] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:31.605982 21247 execute_run.go:90] checking if process for command "run" is running [odo] I1023 15:00:31.606034 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 15:00:31.606068 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:32.286348 21247 exec.go:96] 157 [odo] I1023 15:00:32.298236 21247 exec.go:37] Executing command [/bin/sh -c kill -0 157; echo $?] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:32.491395 21247 exec.go:96] 0 [odo] I1023 15:00:32.493226 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 15:00:32.493409 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:32.655929 21247 exec.go:96] 157 [odo] I1023 15:00:32.658875 21247 exec.go:37] Executing command [/bin/sh -c kill -0 157; echo $?] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:32.850160 21247 exec.go:96] 0 [odo] • Waiting for the application to be ready ... [odo] I1023 15:00:33.854204 21247 exec.go:37] Executing command [/bin/sh -c cat /proc/net/tcp /proc/net/udp /proc/net/tcp6 /proc/net/udp6 || true] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:34.073674 21247 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 15:00:34.073879 21247 exec.go:96] 0: B92B11AC:A384 D110D9AC:01BB 06 00000000:00000000 03:00001485 00000000 0 0 0 3 0000000000000000 [odo] I1023 15:00:34.073958 21247 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 15:00:34.074018 21247 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 15:00:34.074059 21247 exec.go:96] 0: 00000000000000000000000000000000:1F90 00000000000000000000000000000000:0000 0A 00000000:00000000 00:00000000 00000000 1018860000 0 1016641558 1 0000000000000000 100 0 0 10 0 [odo] I1023 15:00:34.074140 21247 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] ✓ Waiting for the application to be ready [1s] [odo] I1023 15:00:34.076452 21247 port.go:346] ports not listening: map[] [odo] - Forwarding from 127.0.0.1:36153 -> 8080 [odo] [odo] I1023 15:00:34.163027 21247 status.go:34] setting inner loop State "Ready" [odo] [odo] ↪ Dev mode [odo] Status: [odo] Watching for changes in the current directory /tmp/4016021150 [odo] [odo] Keyboard Commands: [odo] [Ctrl+c] - Exit and delete resources from the cluster [odo] [p] - Manually apply local changes to the application on the cluster [odo] I1023 15:00:34.163129 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94088200, generation: 2, pods: 1 [odo] I1023 15:00:34.264746 21247 watch.go:348] filesystem watch event: CREATE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 15:00:34.265901 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 15:00:34.266422 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.json" [odo] I1023 15:00:34.266919 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.21247.json" [odo] I1023 15:00:34.267738 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/devfile.yaml" [odo] I1023 15:00:34.268324 21247 file_watcher.go:64] adding watch on path /tmp/4016021150/devfile.yaml [odo] I1023 15:00:34.268418 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/devfile.yaml" [odo] I1023 15:00:34.268783 21247 file_watcher.go:64] adding watch on path /tmp/4016021150/devfile.yaml [odo] I1023 15:00:34.268866 21247 watch.go:348] filesystem watch event: REMOVE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 15:00:34.268939 21247 watch.go:383] error removing watch for /tmp/4016021150/.odo/odo-file-index.json: can't remove non-existent watcher: /tmp/4016021150/.odo/odo-file-index.json [odo] I1023 15:00:34.269000 21247 watch.go:348] filesystem watch event: CREATE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 15:00:34.269350 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/odo-file-index.json" [odo] I1023 15:00:34.269763 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.json" [odo] I1023 15:00:34.270213 21247 watch.go:348] filesystem watch event: WRITE "/tmp/4016021150/.odo/devstate.21247.json" [odo] I1023 15:00:34.270648 21247 status.go:34] setting inner loop State "SyncOutdated" [odo] Pushing files... [odo] [odo] [odo] File /tmp/4016021150/devfile.yaml changed [odo] I1023 15:00:34.270787 21247 watch.go:423] Copying files [/tmp/4016021150/devfile.yaml] to pod [odo] I1023 15:00:34.271444 21247 context.go:172] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 15:00:34.271511 21247 context.go:113] absolute devfile path: '/tmp/4016021150/devfile.yaml' [odo] I1023 15:00:34.272769 21247 content.go:48] converted devfile YAML to JSON [odo] I1023 15:00:34.272988 21247 apiVersion.go:60] devfile schemaVersion: '2.1.0' [odo] I1023 15:00:34.273055 21247 helper.go:56] devfile apiVersion '2.1.0' is supported [odo] I1023 15:00:34.278563 21247 schema.go:61] validated devfile schema [odo] I1023 15:00:34.278942 21247 validate.go:45] Successfully validated devfile sections [odo] I1023 15:00:34.279014 21247 components.go:69] component state: "SyncOutdated" [odo] • Waiting for Kubernetes resources ... [odo] I1023 15:00:34.292331 21247 components.go:260] We are deploying these annotations: map[alpha.image.policy.openshift.io/resolve-names:* odo.dev/project-type:Go] [odo] I1023 15:00:34.338259 21247 utils.go:77] Updating container runtime with mandatory volume mounts [odo] I1023 15:00:34.385531 21247 components.go:346] Creating deployment iytjlq-app [odo] I1023 15:00:34.385569 21247 components.go:347] The component name is iytjlq [odo] I1023 15:00:34.385635 21247 components.go:350] The component already exists, attempting to update it [odo] I1023 15:00:34.385702 21247 components.go:352] Applying deployment [odo] I1023 15:00:34.426829 21247 components.go:361] Successfully updated component iytjlq [odo] I1023 15:00:34.457736 21247 components.go:748] Successfully update Service for component iytjlq [odo] I1023 15:00:34.490022 21247 all.go:46] starting to concurrently query 200 APIs [odo] I1023 15:00:34.491330 21247 all.go:62] fired up all goroutines to query APIs [odo] I1023 15:00:35.500125 21247 all.go:67] all goroutines have returned in 1.010089424s [odo] I1023 15:00:35.500184 21247 all.go:76] query result: objects=8 [odo] I1023 15:00:35.501476 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] I1023 15:00:35.502526 21247 kclient.go:237] Checking if "clusterserviceversions" resource is supported [odo] I1023 15:00:35.502568 21247 service.go:75] Getting list of services [odo] I1023 15:00:35.502617 21247 operators.go:30] Fetching list of operators installed in cluster [odo] I1023 15:00:35.542146 21247 service.go:93] Getting services started from operator: cloud-native-postgresql.v1.18.7 [odo] I1023 15:00:35.542191 21247 service.go:124] Getting instances of: backups.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:35.552643 21247 service.go:124] Getting instances of: clusters.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:35.568214 21247 service.go:124] Getting instances of: poolers.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:35.576644 21247 service.go:124] Getting instances of: scheduledbackups.postgresql.k8s.enterprisedb.io [odo] I1023 15:00:35.587402 21247 service.go:93] Getting services started from operator: service-binding-operator.v1.3.3 [odo] I1023 15:00:35.587438 21247 service.go:124] Getting instances of: bindablekinds.binding.operators.coreos.com [odo] I1023 15:00:35.591547 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 15:00:35.595201 21247 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 15:00:35.599428 21247 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 15:00:35.613093 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 15:00:35.622132 21247 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 15:00:35.631388 21247 kclient.go:237] Checking if "servicebindings" resource is supported [odo] • Syncing files into the container ... [odo] I1023 15:00:35.748801 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150, destBase: ., destFile: . [odo] I1023 15:00:35.748830 21247 file_indexer.go:406] Corrected destinations: base: . file: . [odo] I1023 15:00:35.750024 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.gitignore, destBase: ., destFile: .gitignore [odo] I1023 15:00:35.750049 21247 file_indexer.go:406] Corrected destinations: base: . file: .gitignore [odo] I1023 15:00:35.750485 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/.odo, destBase: ., destFile: .odo [odo] I1023 15:00:35.750504 21247 file_indexer.go:406] Corrected destinations: base: . file: .odo [odo] I1023 15:00:35.750902 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/cluster.yaml, destBase: ., destFile: cluster.yaml [odo] I1023 15:00:35.750921 21247 file_indexer.go:406] Corrected destinations: base: . file: cluster.yaml [odo] I1023 15:00:35.751279 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/devfile.yaml, destBase: ., destFile: devfile.yaml [odo] I1023 15:00:35.751314 21247 file_indexer.go:406] Corrected destinations: base: . file: devfile.yaml [odo] I1023 15:00:35.751676 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.mod, destBase: ., destFile: go.mod [odo] I1023 15:00:35.751693 21247 file_indexer.go:406] Corrected destinations: base: . file: go.mod [odo] I1023 15:00:35.752122 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/go.sum, destBase: ., destFile: go.sum [odo] I1023 15:00:35.752146 21247 file_indexer.go:406] Corrected destinations: base: . file: go.sum [odo] I1023 15:00:35.752502 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/main.go, destBase: ., destFile: main.go [odo] I1023 15:00:35.752527 21247 file_indexer.go:406] Corrected destinations: base: . file: main.go [odo] I1023 15:00:35.752885 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware, destBase: ., destFile: middleware [odo] I1023 15:00:35.752909 21247 file_indexer.go:406] Corrected destinations: base: . file: middleware [odo] I1023 15:00:35.753793 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/middleware/handlers.go, destBase: ., destFile: middleware/handlers.go [odo] I1023 15:00:35.753820 21247 file_indexer.go:406] Corrected destinations: base: . file: middleware/handlers.go [odo] I1023 15:00:35.754208 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models, destBase: ., destFile: models [odo] I1023 15:00:35.754231 21247 file_indexer.go:406] Corrected destinations: base: . file: models [odo] I1023 15:00:35.754955 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/models/models.go, destBase: ., destFile: models/models.go [odo] I1023 15:00:35.754980 21247 file_indexer.go:406] Corrected destinations: base: . file: models/models.go [odo] I1023 15:00:35.755373 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router, destBase: ., destFile: router [odo] I1023 15:00:35.755396 21247 file_indexer.go:406] Corrected destinations: base: . file: router [odo] I1023 15:00:35.756140 21247 file_indexer.go:400] recursiveTar arguments: srcBase: /tmp, srcFile: 4016021150/router/router.go, destBase: ., destFile: router/router.go [odo] I1023 15:00:35.756164 21247 file_indexer.go:406] Corrected destinations: base: . file: router/router.go [odo] I1023 15:00:35.756927 21247 sync.go:138] List of files to be deleted: +[] [odo] I1023 15:00:35.756959 21247 sync.go:140] List of files changed: +[] [odo] ✓ Syncing files into the container [9ms] [odo] I1023 15:00:35.759058 21247 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 15:00:35.759090 21247 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:35.953230 21247 exec.go:96] 157 [odo] I1023 15:00:35.954789 21247 exec.go:37] Executing command [/bin/sh -c kill -0 157; echo $?] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:36.148158 21247 exec.go:96] 0 [odo] I1023 15:00:36.149375 21247 innerloop.go:131] running=true, execRequired=false [odo] • Waiting for the application to be ready ... [odo] I1023 15:00:37.150536 21247 exec.go:37] Executing command [/bin/sh -c cat /proc/net/tcp /proc/net/udp /proc/net/tcp6 /proc/net/udp6 || true] for pod: iytjlq-app-5cd4454fc4-v4fw5 in container: runtime [odo] I1023 15:00:37.321319 21247 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 15:00:37.321482 21247 exec.go:96] 0: B92B11AC:A384 D110D9AC:01BB 06 00000000:00000000 03:00001340 00000000 0 0 0 3 0000000000000000 [odo] I1023 15:00:37.321563 21247 exec.go:96] sl local_address rem_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 15:00:37.321610 21247 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode [odo] I1023 15:00:37.321647 21247 exec.go:96] 0: 00000000000000000000000000000000:1F90 00000000000000000000000000000000:0000 0A 00000000:00000000 00:00000000 00000000 1018860000 0 1016641558 1 0000000000000000 100 0 0 10 0 [odo] I1023 15:00:37.321694 21247 exec.go:96] sl local_address remote_address st tx_queue rx_queue tr tm->when retrnsmt uid timeout inode ref pointer drops [odo] I1023 15:00:37.326426 21247 port.go:346] ports not listening: map[] [odo] ✓ Waiting for the application to be ready [1s] [odo] [odo] ↪ Dev mode [odo] Status: [odo] Watching for changes in the current directory /tmp/4016021150 [odo] [odo] Keyboard Commands: [odo] [Ctrl+c] - Exit and delete resources from the cluster [odo] [p] - Manually apply local changes to the application on the cluster [odo] I1023 15:00:37.326702 21247 status.go:34] setting inner loop State "Ready" [odo] I1023 15:00:37.326821 21247 watch.go:271] deployment watcher Event: Type: MODIFIED, name: iytjlq-app, rv: 94088277, generation: 2, pods: 1 Running oc with args [oc get pods --namespace e2e-test461kue --selector=component=iytjlq -o jsonpath={.items[*].metadata.name}] and odo env: [] [oc] iytjlq-app-5cd4454fc4-v4fw5Running oc with args [oc exec iytjlq-app-5cd4454fc4-v4fw5 --namespace e2e-test461kue -c runtime -- curl http://127.0.0.1:8080/ping] and odo env: [] [oc] pong % Total % Received % Xferd Average Speed Time Time Time Current [oc] Dload Upload Total Spent Left Speed [oc] 0 0 0 0 0 0 0 0 --:--:-- --:--:-- --:--:-- 0 100 4 100 4 0 0 4000 0 --:--:-- --:--:-- --:--:-- 4000 [FAILED] in [It] - /go/odo_1/tests/e2escenarios/e2e_test.go:430 @ 10/23/23 15:00:40.715 Running oc with args [oc get project e2e-test461kue -o jsonpath={.metadata.name}] and odo env: [] [oc] e2e-test461kueDeleting project: e2e-test461kue Running oc with args [oc delete project e2e-test461kue --wait=false] and odo env: [] [oc] project.project.openshift.io "e2e-test461kue" deleted Setting current dir to: /go/odo_1/tests/e2escenarios Deleting dir: /tmp/4016021150 Deleting dir: /tmp/4095656316 << Timeline [FAILED] Expected <*url.Error | 0xc0006abda0>: Post "http://127.0.0.1:36153/api/newuser": EOF { Op: "Post", URL: "http://127.0.0.1:36153/api/newuser", Err: <*errors.errorString | 0xc0001100f0>{s: "EOF"}, } to be nil In [It] at: /go/odo_1/tests/e2escenarios/e2e_test.go:430 @ 10/23/23 15:00:40.715 ------------------------------ • [109.628 seconds] E2E Test starting with non-empty Directory test debugging should verify developer workflow from non-empty Directory /go/odo_1/tests/e2escenarios/e2e_test.go:329 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo init' from /tmp/311360382 << Captured StdOut/StdErr Output ------------------------------ Progress Report for Ginkgo Process #5 Automatically polling progress: E2E Test starting with non-empty Directory should verify developer workflow from non-empty Directory (Spec Runtime: 2m3.405s) /go/odo_1/tests/e2escenarios/e2e_test.go:199 In [It] (Node Runtime: 2m0s) /go/odo_1/tests/e2escenarios/e2e_test.go:199 Begin Captured GinkgoWriter Output >> ... [odo] I1023 15:00:46.779943 21177 copy.go:171] Corrected destinations: base: /projects file: src/main/java/com/example/demo/DemoApplication.java [odo] ✓ Syncing files into the container [2s] [odo] I1023 15:00:48.468205 21177 kubeexec.go:40] GetProcessInfoForCommand for "run" [odo] I1023 15:00:48.468250 21177 exec.go:37] Executing command [/bin/sh -c cat /opt/odo/.odo_cmd_run.pid || true] for pod: vbvzuk-app-57dbfb879-l9kx4 in container: tools [odo] I1023 15:00:48.765036 21177 exec.go:96] 109 [odo] I1023 15:00:48.769209 21177 exec.go:37] Executing command [/bin/sh -c kill -0 109; echo $?] for pod: vbvzuk-app-57dbfb879-l9kx4 in container: tools [odo] I1023 15:00:49.396006 21177 exec.go:96] 0 [odo] I1023 15:00:49.397856 21177 innerloop.go:131] running=true, execRequired=true [odo] • Building your application in container (command: build) ... [odo] I1023 15:00:49.398126 21177 exec.go:37] Executing command [/bin/sh -c cd ${PROJECT_SOURCE} && (mvn clean -Dmaven.repo.local=/home/user/.m2/repository package -Dmaven.test.skip=true) 1>>/proc/1/fd/1 2>>/proc/1/fd/2] for pod: vbvzuk-app-57dbfb879-l9kx4 in container: tools << End Captured GinkgoWriter Output Spec Goroutine goroutine 64 [select] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc0002b2150, {0x2f3fe50?, 0xc00072a720}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc0002b2150, {0x2f3fe50, 0xc00072a720}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/redhat-developer/odo/tests/helper.WaitForOutputToContain({0x2b61f03, 0x8}, 0xc0007e8000?, 0xc00010e300?, 0xc00072a180) /go/odo_1/tests/helper/helper_run.go:54 github.com/redhat-developer/odo/tests/helper.(*DevSession).WaitSync(0xc0007e7d28) /go/odo_1/tests/helper/helper_dev.go:279 > github.com/redhat-developer/odo/tests/e2escenarios.glob..func1.6.2() /go/odo_1/tests/e2escenarios/e2e_test.go:238 | | helper.ReplaceString(filepath.Join(commonVar.Context, "src", "main", "java", "com", "example", "demo", "DemoApplication.java"), "Hello World!", "Hello updated World!") > err = devSession.WaitSync() | Expect(err).ToNot(HaveOccurred()) | // "should update the changes" github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0xc00041bc00, 0xa}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ Progress Report for Ginkgo Process #3 Automatically polling progress: E2E Test starting with empty Directory should verify developer workflow from empty Directory (Spec Runtime: 2m3.676s) /go/odo_1/tests/e2escenarios/e2e_test.go:63 In [It] (Node Runtime: 2m0.001s) /go/odo_1/tests/e2escenarios/e2e_test.go:63 Begin Captured GinkgoWriter Output >> ... [odo] Keyboard Commands: [odo] [Ctrl+c] - Exit and delete resources from the cluster [odo] [p] - Manually apply local changes to the application on the cluster [odo] I1023 15:00:58.778820 21460 watch.go:271] deployment watcher Event: Type: MODIFIED, name: lgkdzs-app, rv: 94088517, generation: 1, pods: 1 [odo] I1023 15:00:58.909006 21460 watch.go:348] filesystem watch event: REMOVE "/tmp/3025994633/.odo/odo-file-index.json" [odo] I1023 15:00:58.909329 21460 watch.go:383] error removing watch for /tmp/3025994633/.odo/odo-file-index.json: can't remove non-existent watcher: /tmp/3025994633/.odo/odo-file-index.json [odo] I1023 15:00:58.909500 21460 watch.go:348] filesystem watch event: CREATE "/tmp/3025994633/.odo/odo-file-index.json" [odo] I1023 15:00:58.917969 21460 watch.go:348] filesystem watch event: WRITE "/tmp/3025994633/.odo/odo-file-index.json" [odo] I1023 15:00:58.923204 21460 watch.go:348] filesystem watch event: WRITE "/tmp/3025994633/.odo/devstate.json" [odo] I1023 15:00:58.934453 21460 watch.go:348] filesystem watch event: WRITE "/tmp/3025994633/.odo/devstate.21460.json" << End Captured GinkgoWriter Output Spec Goroutine goroutine 28 [select] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc00046a4d0, {0x2f3fe50?, 0xc000dfcd50}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc00046a4d0, {0x2f3fe50, 0xc000dfcd50}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/redhat-developer/odo/tests/helper.WaitForOutputToContain({0x2b6ff84, 0xf}, 0x0?, 0x3?, 0xc000dfccf0) /go/odo_1/tests/helper/helper_run.go:54 github.com/redhat-developer/odo/tests/helper.StartDevMode({{0x0, 0x0, 0x0}, {0x0, 0x0, 0x0}, 0x0, 0x0, 0x0, 0x0, ...}) /go/odo_1/tests/helper/helper_dev.go:192 > github.com/redhat-developer/odo/tests/e2escenarios.glob..func1.5.2() /go/odo_1/tests/e2escenarios/e2e_test.go:155 | | // start dev mode again > devSession, err = helper.StartDevMode(helper.DevSessionOpts{}) | Expect(err).ToNot(HaveOccurred()) | github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0x103b705, 0x0}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ • [152.238 seconds] E2E Test starting with empty Directory should verify developer workflow from empty Directory /go/odo_1/tests/e2escenarios/e2e_test.go:63 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo init' from /tmp/3025994633 Spawning '/go/bin/odo delete component' from /tmp/3025994633 << Captured StdOut/StdErr Output ------------------------------ Progress Report for Ginkgo Process #5 Automatically polling progress: E2E Test starting with non-empty Directory should verify developer workflow from non-empty Directory (Spec Runtime: 4m3.411s) /go/odo_1/tests/e2escenarios/e2e_test.go:199 In [It] (Node Runtime: 4m0.006s) /go/odo_1/tests/e2escenarios/e2e_test.go:199 Begin Captured GinkgoWriter Output >> ... [odo] I1023 15:02:47.189982 21647 service.go:124] Getting instances of: clusterworkloadresourcemappings.servicebinding.io [odo] I1023 15:02:47.193045 21647 service.go:124] Getting instances of: servicebindings.binding.operators.coreos.com [odo] I1023 15:02:47.200869 21647 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 15:02:47.208840 21647 service.go:124] Getting instances of: servicebindings.servicebinding.io [odo] I1023 15:02:47.225696 21647 components.go:141] Deployment has 0 ready replicas. Waiting new event... [odo] I1023 15:02:47.225783 21647 status.go:34] setting inner loop State "WaitDeployment" [odo] I1023 15:02:47.225849 21647 watch.go:271] deployment watcher Event: Type: MODIFIED, name: vbvzuk-app, rv: 94089694, generation: 1, pods: 0 [odo] ================================================================================================================================================================== [odo] ⚠ 0/3 nodes are available: 3 pod has unbound immediate PersistentVolumeClaims. preemption: 0/3 nodes are available: 3 Preemption is not helpful for scheduling. [odo] ================================================================================================================================================================== << End Captured GinkgoWriter Output Spec Goroutine goroutine 64 [select] github.com/onsi/gomega/internal.(*AsyncAssertion).match(0xc000426d90, {0x2f3fe50?, 0xc0005d7140}, 0x1, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:538 github.com/onsi/gomega/internal.(*AsyncAssertion).Should(0xc000426d90, {0x2f3fe50, 0xc0005d7140}, {0x0, 0x0, 0x0}) /go/odo_1/vendor/github.com/onsi/gomega/internal/async_assertion.go:145 github.com/redhat-developer/odo/tests/helper.WaitForOutputToContain({0x2b6ff84, 0xf}, 0x0?, 0x3?, 0xc0005d70e0) /go/odo_1/tests/helper/helper_run.go:54 github.com/redhat-developer/odo/tests/helper.StartDevMode({{0x0, 0x0, 0x0}, {0x0, 0x0, 0x0}, 0x0, 0x0, 0x0, 0x0, ...}) /go/odo_1/tests/helper/helper_dev.go:192 > github.com/redhat-developer/odo/tests/e2escenarios.glob..func1.6.2() /go/odo_1/tests/e2escenarios/e2e_test.go:282 | | // start dev mode again > devSession, err = helper.StartDevMode(helper.DevSessionOpts{}) | Expect(err).ToNot(HaveOccurred()) | github.com/onsi/ginkgo/v2/internal.extractBodyFunction.func3({0xc00041bc00, 0xa}) /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/node.go:463 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode.func3() /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:865 github.com/onsi/ginkgo/v2/internal.(*Suite).runNode /go/odo_1/vendor/github.com/onsi/ginkgo/v2/internal/suite.go:852 ------------------------------ • [314.823 seconds] E2E Test starting with non-empty Directory should verify developer workflow from non-empty Directory /go/odo_1/tests/e2escenarios/e2e_test.go:199 Captured StdOut/StdErr Output >> Spawning '/go/bin/odo init' from /tmp/616526351 Spawning '/go/bin/odo delete component' from /tmp/616526351 << Captured StdOut/StdErr Output ------------------------------ Summarizing 1 Failure: [FAIL] E2E Test starting with non-empty Directory add Binding [It] should verify developer workflow of using binding as env in innerloop /go/odo_1/tests/e2escenarios/e2e_test.go:430 Ran 4 of 4 Specs in 314.833 seconds FAIL! -- 3 Passed | 1 Failed | 0 Pending | 0 Skipped Ginkgo ran 1 suite in 5m33.398189238s Test Suite Failed exit status 1 make: *** [Makefile:236: test-e2e] Error 1