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