This job view page is being replaced by Spyglass soon. Check out the new job view.
PRkarlkfi: chore: Add PHONY to Makefile targets
ResultFAILURE
Tests 0 failed / 0 succeeded
Started2022-04-20 19:06
Elapsed11m25s
Revision9a1019889901cb27497dbb0c85c99849d87d9c74
Refs 580

No Test Failures!


Error lines from build-log.txt

... skipping 500 lines ...
I0420 19:09:40.714543   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:09:40.714609   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:09:40.722053   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:09:40.722165   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:09:40.722195   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:09:40.722223   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 2)
I0420 19:09:40.722274   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-81305453_pod2__Pod", Error: "annotation prevents deletion (\"client.lifecycle.config.k8s.io/deletion\": \"detach\")" }
I0420 19:09:40.722333   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-81305453_pod1__Pod", Error: "annotation prevents deletion (\"cli-utils.sigs.k8s.io/on-remove\": \"keep\")" }
I0420 19:09:40.722366   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:09:40.722374   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:09:40.722383   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Started" }
I0420 19:09:40.722403   18267 inv_set_task.go:59] inventory set task starting (name: "inventory-set-0")
STEP: Verify deployment still exists and has the config.k8s.io/owning-inventory annotation
I0420 19:09:40.722441   18267 inv_set_task.go:123] inventory set task completing (name: "inventory-set-0")
... skipping 24 lines ...
I0420 19:09:40.819811   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Successful", Identifier: "e2e-test-81305453_nginx-deployment_apps_Deployment" }
I0420 19:09:40.819986   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
I0420 19:09:40.820142   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:09:40.820296   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:09:40.820410   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:09:40.820583   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 2)
I0420 19:09:40.831644   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-81305453_pod2__Pod", Error: "annotation prevents deletion (\"client.lifecycle.config.k8s.io/deletion\": \"detach\")" }
I0420 19:09:40.840067   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-81305453_pod1__Pod", Error: "annotation prevents deletion (\"cli-utils.sigs.k8s.io/on-remove\": \"keep\")" }
I0420 19:09:40.840128   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:09:40.840140   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:09:40.840164   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-1", Action: "Wait", Type: "Started" }
I0420 19:09:40.840174   18267 task.go:94] wait task starting (name: "wait-1", objects: 2)
I0420 19:09:40.840185   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "e2e-test-81305453_pod2__Pod" }
I0420 19:09:40.840199   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "e2e-test-81305453_pod1__Pod" }
... skipping 125 lines ...
I0420 19:09:48.075761   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:09:48.076149   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:09:48.095228   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:09:48.095283   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:09:48.095304   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:09:48.095343   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 2)
I0420 19:09:48.116530   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Failed", Identifier: "_invalidexamples.cli-utils.example.io_apiextensions.k8s.io_CustomResourceDefinition", Error: "error when creating \"unstructured\": CustomResourceDefinition.apiextensions.k8s.io \"invalidexamples.cli-utils.example.io\" is invalid: [spec.versions: Invalid value: []apiextensions.CustomResourceDefinitionVersion(nil): must have exactly one version marked as storage version, status.storedVersions: Invalid value: []string(nil): must have at least one stored version]" }
I0420 19:09:48.135091   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:09:48.135227   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:09:48.135282   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:09:48.135322   18267 task.go:94] wait task starting (name: "wait-0", objects: 2)
I0420 19:09:48.135356   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "_invalidexamples.cli-utils.example.io_apiextensions.k8s.io_CustomResourceDefinition" }
I0420 19:09:48.135432   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Pending", Identifier: "e2e-test-06010783_pod1__Pod" }
... skipping 312 lines ...
                      Status: 1,
                      Identifier: {
                          Namespace: "e2e-test-91363647-ns1",
                          Name: "pod1",
                          GroupKind: {Group: "", Kind: "Pod"},
                      },
                      Error: nil,
                  },
                  WaitEvent: nil,
                  ValidationEvent: nil,
              },
              {
                  EventType: 2,
... skipping 96 lines ...
                      Status: 1,
                      Identifier: {
                          Namespace: "e2e-test-91363647-ns1",
                          Name: "pod3",
                          GroupKind: {Group: "", Kind: "Pod"},
                      },
                      Error: nil,
                  },
                  WaitEvent: nil,
                  ValidationEvent: nil,
              },
              {
                  EventType: 2,
... skipping 96 lines ...
                      Status: 1,
                      Identifier: {
                          Namespace: "e2e-test-91363647-ns2",
                          Name: "pod2",
                          GroupKind: {Group: "", Kind: "Pod"},
                      },
                      Error: nil,
                  },
                  WaitEvent: nil,
                  ValidationEvent: nil,
              },
              {
                  EventType: 2,
... skipping 116 lines ...
                      Status: 1,
                      Identifier: {
                          Namespace: "e2e-test-91363647-ns1",
                          Name: "pod1",
                          GroupKind: {Group: "", Kind: "Pod"},
                      },
                      Error: nil,
                  },
                  WaitEvent: nil,
                  ValidationEvent: nil,
              },
              {
                  EventType: 2,
... skipping 96 lines ...
                      Status: 1,
                      Identifier: {
                          Namespace: "e2e-test-91363647-ns1",
                          Name: "pod3",
                          GroupKind: {Group: "", Kind: "Pod"},
                      },
                      Error: nil,
                  },
                  WaitEvent: nil,
                  ValidationEvent: nil,
              },
              {
                  EventType: 2,
... skipping 96 lines ...
                      Status: 1,
                      Identifier: {
                          Namespace: "e2e-test-91363647-ns2",
                          Name: "pod2",
                          GroupKind: {Group: "", Kind: "Pod"},
                      },
                      Error: nil,
                  },
                  WaitEvent: nil,
                  ValidationEvent: nil,
              },
              {
                  EventType: 2,
... skipping 275 lines ...
I0420 19:11:03.440316   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:11:03.440385   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:11:03.450483   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:11:03.450526   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:11:03.450554   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:11:03.450585   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:11:03.453866   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Skipped", Identifier: "e2e-test-47118120_pod1__Pod", Error: "dependency scheduled for delete: e2e-test-47118120_pod2__Pod" }
I0420 19:11:03.453931   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:11:03.453944   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:11:03.453964   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:11:03.453982   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:11:03.453992   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "e2e-test-47118120_pod1__Pod" }
I0420 19:11:03.454008   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
I0420 19:11:03.454034   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:11:03.454053   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:11:03.454062   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:11:03.454087   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 1)
I0420 19:11:03.454162   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-47118120_pod2__Pod", Error: "dependent scheduled for apply: e2e-test-47118120_pod1__Pod" }
I0420 19:11:03.454220   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:11:03.454229   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:11:03.454238   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-1", Action: "Wait", Type: "Started" }
I0420 19:11:03.454252   18267 task.go:94] wait task starting (name: "wait-1", objects: 1)
I0420 19:11:03.454260   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "e2e-test-47118120_pod2__Pod" }
I0420 19:11:03.454272   18267 task.go:186] all objects reconciled or skipped (name: "wait-1")
... skipping 65 lines ...
I0420 19:11:07.671237   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:11:07.671344   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:11:07.681287   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:11:07.681327   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:11:07.681349   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:11:07.681376   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:11:07.684632   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Skipped", Identifier: "e2e-test-16516241-ns1_pod-b__Pod", Error: "dependency scheduled for delete: _e2e-test-16516241-ns1__Namespace" }
I0420 19:11:07.684707   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:11:07.684721   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:11:07.684744   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:11:07.684759   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:11:07.684768   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "e2e-test-16516241-ns1_pod-b__Pod" }
I0420 19:11:07.684789   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
I0420 19:11:07.684825   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:11:07.684852   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:11:07.684862   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:11:07.684904   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 1)
I0420 19:11:07.684942   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "_e2e-test-16516241-ns1__Namespace", Error: "namespace still in use: e2e-test-16516241-ns1" }
I0420 19:11:07.684990   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:11:07.684998   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:11:07.685006   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-1", Action: "Wait", Type: "Started" }
I0420 19:11:07.685013   18267 task.go:94] wait task starting (name: "wait-1", objects: 1)
I0420 19:11:07.685021   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "_e2e-test-16516241-ns1__Namespace" }
I0420 19:11:07.685033   18267 task.go:186] all objects reconciled or skipped (name: "wait-1")
... skipping 119 lines ...
I0420 19:11:40.163625   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:11:40.182024   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:11:40.182060   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:11:40.182081   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:11:40.182088   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:11:40.182141   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Pending", Identifier: "e2e-test-21536077_pod1__Pod" }
I0420 19:11:56.199080   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Failed", Identifier: "e2e-test-21536077_pod1__Pod" }
I0420 19:11:56.199163   18267 task.go:407] all objects reconciled or skipped (name: "wait-0")
I0420 19:11:56.199183   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:11:56.199190   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:11:56.199240   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Started" }
I0420 19:11:56.199363   18267 inv_set_task.go:59] inventory set task starting (name: "inventory-set-0")
I0420 19:11:56.205738   18267 inv_set_task.go:123] inventory set task completing (name: "inventory-set-0")
... skipping 56 lines ...
I0420 19:12:26.591753   18267 depends.go:144] adding vertex: e2e-test-77214118_pod1__Pod
I0420 19:12:26.591818   18267 depends.go:144] adding vertex: e2e-test-77214118_nginx-deployment_apps_Deployment
I0420 19:12:26.591828   18267 depends.go:144] adding vertex: e2e-test-77214118_pod3__Pod
I0420 19:12:26.591835   18267 depends.go:144] adding vertex: e2e-test-77214118_pod-a__Pod
I0420 19:12:26.591842   18267 depends.go:144] adding vertex: e2e-test-77214118_pod-b__Pod
I0420 19:12:26.591889   18267 depends.go:258] adding edge from: e2e-test-77214118_nginx-deployment_apps_Deployment, to: e2e-test-77214118_pod1__Pod
I0420 19:12:26.591962   18267 depends.go:255] failed to add edges: invalid "config.kubernetes.io/depends-on" annotation: external dependency: /namespaces/e2e-test-77214118/Pod/pod3 -> /namespaces/e2e-test-77214118/Pod/pod0
I0420 19:12:26.592346   18267 depends.go:191] adding edge from: e2e-test-77214118_pod-a__Pod, to: e2e-test-77214118_pod-b__Pod
I0420 19:12:26.592683   18267 depends.go:191] adding edge from: e2e-test-77214118_pod-b__Pod, to: e2e-test-77214118_pod-a__Pod
I0420 19:12:26.592824   18267 depends.go:188] failed to add edges: invalid "config.kubernetes.io/apply-time-mutation" annotation: external dependency: /namespaces/e2e-test-77214118/Pod/pod-b -> /Pod/pod-a
I0420 19:12:26.592974   18267 solver.go:159] adding inventory add task (2 objects)
I0420 19:12:26.593115   18267 solver.go:243] adding apply task (1 objects)
I0420 19:12:26.593190   18267 solver.go:265] adding wait task
I0420 19:12:26.593263   18267 solver.go:243] adding apply task (1 objects)
I0420 19:12:26.593349   18267 solver.go:265] adding wait task
I0420 19:12:26.593418   18267 solver.go:216] adding inventory set task
... skipping 33 lines ...
STEP: verify podA not found
STEP: verify podB not found
STEP: modify deployment1 depends-on annotation to be invalid
STEP: destroy valid objects and skip invalid objects
I0420 19:12:32.706349   18267 depends.go:144] adding vertex: e2e-test-77214118_nginx-deployment_apps_Deployment
I0420 19:12:32.706393   18267 depends.go:144] adding vertex: e2e-test-77214118_pod1__Pod
I0420 19:12:32.706440   18267 depends.go:217] failed to add edges from: e2e-test-77214118_nginx-deployment_apps_Deployment: invalid "config.kubernetes.io/depends-on" annotation: failed to parse object reference (index: 0): expected 3 or 5 fields, found 1: "invalid"
I0420 19:12:32.706484   18267 solver.go:282] adding prune task (1 objects)
I0420 19:12:32.706528   18267 solver.go:265] adding wait task
I0420 19:12:32.706539   18267 solver.go:226] adding delete inventory task
I0420 19:12:32.706617   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Delete", Type: "Started" }
I0420 19:12:32.707426   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 1)
I0420 19:12:32.724515   18267 context.go:66] Sending event: DeleteEvent{ GroupName: "prune-0", Status: "Successful", Identifier: "e2e-test-77214118_pod1__Pod" }
... skipping 124 lines ...
I0420 19:12:45.127186   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:12:45.127331   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:12:45.137036   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:12:45.137081   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:12:45.137102   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:12:45.137137   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:12:45.140407   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Skipped", Identifier: "e2e-test-43131123_nginx-deployment_apps_Deployment", Error: "inventory policy prevented actuation (strategy: Apply, status: NoMatch, policy: MustMatch)" }
I0420 19:12:45.140483   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:12:45.140497   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:12:45.140524   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:12:45.140533   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:12:45.140546   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "e2e-test-43131123_nginx-deployment_apps_Deployment" }
I0420 19:12:45.140562   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
... skipping 458 lines ...
I0420 19:13:54.352549   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:13:54.352740   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:13:54.360626   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:13:54.360899   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:13:54.361064   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:13:54.361233   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 2)
I0420 19:13:54.361416   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-77042924_pod2__Pod", Error: "annotation prevents deletion (\"client.lifecycle.config.k8s.io/deletion\": \"detach\")" }
I0420 19:13:54.361645   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-77042924_pod1__Pod", Error: "annotation prevents deletion (\"cli-utils.sigs.k8s.io/on-remove\": \"keep\")" }
I0420 19:13:54.361825   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:13:54.361991   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:13:54.362103   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Started" }
I0420 19:13:54.362337   18267 inv_set_task.go:59] inventory set task starting (name: "inventory-set-0")
I0420 19:13:54.362508   18267 inv_set_task.go:123] inventory set task completing (name: "inventory-set-0")
I0420 19:13:54.362664   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Finished" }
... skipping 24 lines ...
I0420 19:13:54.559751   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Successful", Identifier: "e2e-test-77042924_nginx-deployment_apps_Deployment" }
I0420 19:13:54.559777   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
I0420 19:13:54.559800   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:13:54.559818   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:13:54.559830   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:13:54.559865   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 2)
I0420 19:13:54.610373   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-77042924_pod2__Pod", Error: "annotation prevents deletion (\"client.lifecycle.config.k8s.io/deletion\": \"detach\")" }
I0420 19:13:54.631286   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-77042924_pod1__Pod", Error: "annotation prevents deletion (\"cli-utils.sigs.k8s.io/on-remove\": \"keep\")" }
I0420 19:13:54.631358   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:13:54.631381   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:13:54.631400   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-1", Action: "Wait", Type: "Started" }
I0420 19:13:54.631411   18267 task.go:94] wait task starting (name: "wait-1", objects: 2)
I0420 19:13:54.631423   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "e2e-test-77042924_pod2__Pod" }
I0420 19:13:54.631546   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "e2e-test-77042924_pod1__Pod" }
... skipping 125 lines ...
I0420 19:14:03.915349   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:14:03.915445   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:14:03.936491   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:14:03.936564   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:14:03.936603   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:14:03.936648   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 2)
I0420 19:14:03.945581   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Failed", Identifier: "_invalidexamples.cli-utils.example.io_apiextensions.k8s.io_CustomResourceDefinition", Error: "error when creating \"unstructured\": CustomResourceDefinition.apiextensions.k8s.io \"invalidexamples.cli-utils.example.io\" is invalid: [spec.versions: Invalid value: []apiextensions.CustomResourceDefinitionVersion(nil): must have exactly one version marked as storage version, status.storedVersions: Invalid value: []string(nil): must have at least one stored version]" }
I0420 19:14:03.963031   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:14:03.963081   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:14:03.963115   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:14:03.963128   18267 task.go:94] wait task starting (name: "wait-0", objects: 2)
I0420 19:14:03.963138   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "_invalidexamples.cli-utils.example.io_apiextensions.k8s.io_CustomResourceDefinition" }
I0420 19:14:03.963175   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Pending", Identifier: "e2e-test-18684469_pod1__Pod" }
... skipping 430 lines ...
I0420 19:15:24.309330   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:15:24.309400   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:15:24.332019   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:15:24.332083   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:15:24.332105   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:15:24.332142   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:15:24.336509   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Skipped", Identifier: "e2e-test-53094341_pod1__Pod", Error: "dependency scheduled for delete: e2e-test-53094341_pod2__Pod" }
I0420 19:15:24.336587   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:15:24.336601   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:15:24.336639   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:15:24.336696   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:15:24.336709   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "e2e-test-53094341_pod1__Pod" }
I0420 19:15:24.336737   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
I0420 19:15:24.336763   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:15:24.336780   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:15:24.336790   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:15:24.336871   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 1)
I0420 19:15:24.336921   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "e2e-test-53094341_pod2__Pod", Error: "dependent scheduled for apply: e2e-test-53094341_pod1__Pod" }
I0420 19:15:24.336970   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:15:24.336978   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:15:24.336987   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-1", Action: "Wait", Type: "Started" }
I0420 19:15:24.336995   18267 task.go:94] wait task starting (name: "wait-1", objects: 1)
I0420 19:15:24.337006   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "e2e-test-53094341_pod2__Pod" }
I0420 19:15:24.337026   18267 task.go:186] all objects reconciled or skipped (name: "wait-1")
... skipping 65 lines ...
I0420 19:15:28.672061   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Started" }
I0420 19:15:28.672110   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:15:28.694827   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:15:28.694891   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:15:28.694945   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:15:28.694982   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:15:28.702208   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Skipped", Identifier: "e2e-test-01800055-ns1_pod-b__Pod", Error: "dependency scheduled for delete: _e2e-test-01800055-ns1__Namespace" }
I0420 19:15:28.702318   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:15:28.702345   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:15:28.702402   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:15:28.702461   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:15:28.702478   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "e2e-test-01800055-ns1_pod-b__Pod" }
I0420 19:15:28.702514   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
I0420 19:15:28.702548   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:15:28.702560   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:15:28.702567   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Started" }
I0420 19:15:28.702626   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 1)
I0420 19:15:28.702680   18267 context.go:66] Sending event: PruneEvent{ GroupName: "prune-0", Status: "Skipped", Identifier: "_e2e-test-01800055-ns1__Namespace", Error: "namespace still in use: e2e-test-01800055-ns1" }
I0420 19:15:28.702724   18267 prune_task.go:74] prune task completing (name: "prune-0")
I0420 19:15:28.702731   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Prune", Type: "Finished" }
I0420 19:15:28.702761   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-1", Action: "Wait", Type: "Started" }
I0420 19:15:28.702776   18267 task.go:94] wait task starting (name: "wait-1", objects: 1)
I0420 19:15:28.702792   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-1", Status: "Skipped", Identifier: "_e2e-test-01800055-ns1__Namespace" }
I0420 19:15:28.702804   18267 task.go:186] all objects reconciled or skipped (name: "wait-1")
... skipping 119 lines ...
I0420 19:15:49.263907   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:15:49.279559   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:15:49.279604   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:15:49.279668   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:15:49.279867   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:15:49.279978   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Pending", Identifier: "e2e-test-99808656_pod1__Pod" }
I0420 19:16:05.259110   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Failed", Identifier: "e2e-test-99808656_pod1__Pod" }
I0420 19:16:05.259226   18267 task.go:407] all objects reconciled or skipped (name: "wait-0")
I0420 19:16:05.259251   18267 task.go:116] wait task completing (name: "wait-0",): context canceled
I0420 19:16:05.259262   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Finished" }
I0420 19:16:05.259297   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Started" }
I0420 19:16:05.259324   18267 inv_set_task.go:59] inventory set task starting (name: "inventory-set-0")
I0420 19:16:05.271617   18267 inv_set_task.go:123] inventory set task completing (name: "inventory-set-0")
... skipping 56 lines ...
I0420 19:16:35.681485   18267 depends.go:144] adding vertex: e2e-test-41394898_pod1__Pod
I0420 19:16:35.681522   18267 depends.go:144] adding vertex: e2e-test-41394898_nginx-deployment_apps_Deployment
I0420 19:16:35.681530   18267 depends.go:144] adding vertex: e2e-test-41394898_pod3__Pod
I0420 19:16:35.681535   18267 depends.go:144] adding vertex: e2e-test-41394898_pod-a__Pod
I0420 19:16:35.681541   18267 depends.go:144] adding vertex: e2e-test-41394898_pod-b__Pod
I0420 19:16:35.681567   18267 depends.go:258] adding edge from: e2e-test-41394898_nginx-deployment_apps_Deployment, to: e2e-test-41394898_pod1__Pod
I0420 19:16:35.681589   18267 depends.go:255] failed to add edges: invalid "config.kubernetes.io/depends-on" annotation: external dependency: /namespaces/e2e-test-41394898/Pod/pod3 -> /namespaces/e2e-test-41394898/Pod/pod0
I0420 19:16:35.681838   18267 depends.go:191] adding edge from: e2e-test-41394898_pod-a__Pod, to: e2e-test-41394898_pod-b__Pod
I0420 19:16:35.682012   18267 depends.go:191] adding edge from: e2e-test-41394898_pod-b__Pod, to: e2e-test-41394898_pod-a__Pod
I0420 19:16:35.682148   18267 depends.go:188] failed to add edges: invalid "config.kubernetes.io/apply-time-mutation" annotation: external dependency: /namespaces/e2e-test-41394898/Pod/pod-b -> /Pod/pod-a
I0420 19:16:35.682262   18267 solver.go:159] adding inventory add task (2 objects)
I0420 19:16:35.682330   18267 solver.go:243] adding apply task (1 objects)
I0420 19:16:35.682364   18267 solver.go:265] adding wait task
I0420 19:16:35.682397   18267 solver.go:243] adding apply task (1 objects)
I0420 19:16:35.682436   18267 solver.go:265] adding wait task
I0420 19:16:35.682472   18267 solver.go:216] adding inventory set task
... skipping 33 lines ...
STEP: verify podA not found
STEP: verify podB not found
STEP: modify deployment1 depends-on annotation to be invalid
STEP: destroy valid objects and skip invalid objects
I0420 19:16:41.762744   18267 depends.go:144] adding vertex: e2e-test-41394898_pod1__Pod
I0420 19:16:41.762779   18267 depends.go:144] adding vertex: e2e-test-41394898_nginx-deployment_apps_Deployment
I0420 19:16:41.762798   18267 depends.go:217] failed to add edges from: e2e-test-41394898_nginx-deployment_apps_Deployment: invalid "config.kubernetes.io/depends-on" annotation: failed to parse object reference (index: 0): expected 3 or 5 fields, found 1: "invalid"
I0420 19:16:41.762826   18267 solver.go:282] adding prune task (1 objects)
I0420 19:16:41.762874   18267 solver.go:265] adding wait task
I0420 19:16:41.762881   18267 solver.go:226] adding delete inventory task
I0420 19:16:41.762917   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "prune-0", Action: "Delete", Type: "Started" }
I0420 19:16:41.762948   18267 prune_task.go:55] prune task starting (name: "prune-0", objects: 1)
I0420 19:16:41.768781   18267 context.go:66] Sending event: DeleteEvent{ GroupName: "prune-0", Status: "Successful", Identifier: "e2e-test-41394898_pod1__Pod" }
... skipping 125 lines ...
I0420 19:16:56.088218   18267 inv_add_task.go:48] inventory add task starting (name: "inventory-add-0")
I0420 19:16:56.099189   18267 context.go:66] Sending event: StatusEvent{ Status: "Current", Generation: 1, Identifier: "e2e-test-92732837_nginx-deployment_apps_Deployment" }
I0420 19:16:56.101747   18267 inv_add_task.go:94] inventory add task completing (name: "inventory-add-0")
I0420 19:16:56.101791   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-add-0", Action: "Inventory", Type: "Finished" }
I0420 19:16:56.101813   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Started" }
I0420 19:16:56.101841   18267 apply_task.go:91] apply task starting (name: "apply-0", objects: 1)
I0420 19:16:56.104906   18267 context.go:66] Sending event: ApplyEvent{ GroupName: "apply-0", Status: "Skipped", Identifier: "e2e-test-92732837_nginx-deployment_apps_Deployment", Error: "inventory policy prevented actuation (strategy: Apply, status: NoMatch, policy: MustMatch)" }
I0420 19:16:56.105012   18267 apply_task.go:222] apply task completing (name: "apply-0")
I0420 19:16:56.105025   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "apply-0", Action: "Apply", Type: "Finished" }
I0420 19:16:56.105065   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "wait-0", Action: "Wait", Type: "Started" }
I0420 19:16:56.105107   18267 task.go:94] wait task starting (name: "wait-0", objects: 1)
I0420 19:16:56.105125   18267 context.go:66] Sending event: WaitEvent{ GroupName: "wait-0", Status: "Skipped", Identifier: "e2e-test-92732837_nginx-deployment_apps_Deployment" }
I0420 19:16:56.105155   18267 task.go:186] all objects reconciled or skipped (name: "wait-0")
... skipping 158 lines ...
I0420 19:17:30.436811   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Started" }
I0420 19:17:30.436829   18267 inv_set_task.go:59] inventory set task starting (name: "inventory-set-0")
I0420 19:17:30.447442   18267 inv_set_task.go:123] inventory set task completing (name: "inventory-set-0")
I0420 19:17:30.447507   18267 context.go:66] Sending event: ActionGroupEvent{ GroupName: "inventory-set-0", Action: "Inventory", Type: "Finished" }
STEP: Verify inventory
STEP: Apply second set of resources, using same inventory name but different ID
STEP: Verify that we get the correct error

• [SLOW TEST:10.077 seconds]
Applier
/home/prow/go/src/sigs.k8s.io/cli-utils/test/e2e/e2e_test.go:49
  NameStrategy
  /home/prow/go/src/sigs.k8s.io/cli-utils/test/e2e/e2e_test.go:236
    InventoryIDMismatch
    /home/prow/go/src/sigs.k8s.io/cli-utils/test/e2e/e2e_test.go:258
------------------------------


Summarizing 1 Failure:

[Fail] Applier InventoryConfigMap Basic [It] DependsOn 
/home/prow/go/src/sigs.k8s.io/cli-utils/test/e2e/depends_on_test.go:726

Ran 39 of 39 Specs in 512.989 seconds
FAIL! -- 38 Passed | 1 Failed | 0 Pending | 0 Skipped
--- FAIL: TestE2e (513.00s)
FAIL

Ginkgo ran 1 suite in 9m31.753527082s
Test Suite Failed
make: *** [Makefile:85: test-e2e] Error 1
+ EXIT_VALUE=2
+ set +o xtrace
Cleaning up after docker in docker.
================================================================================
Cleaning up after docker
c7dc3a96a676
... skipping 4 lines ...