metrumresearchgroup / mrgvalprep

Helpers for prepping inputs to mrgvalidate
https://metrumresearchgroup.github.io/mrgvalprep
Other
1 stars 0 forks source link

Feat/go json parser #10

Closed seth127 closed 3 years ago

seth127 commented 3 years ago

Closes https://github.com/metrumresearchgroup/mrgvalprep/issues/9

seth127 commented 3 years ago

@Dreznel @shairozan I think this is in pretty good shape, but lemme know if there are some more edge cases you think we should test in here.

There are also a couple design choices, documented here, that I'm open to feedback on. I think these might require some slight changes to some of the pkgr and/or BAPI test code, but hopefully not much. This output can be a little convoluted though, and this approached seemed best to me as far as how to parse in into something that makes sense in the final docs.

I also parsed the bbi suite and the pkgr output @Dreznel sent me (although I don't think this is the full output?) and I'll post that below.

seth127 commented 3 years ago

Current bbi test outputs (only the integration tests) and the parsed tibble.

Screen Shot 2021-10-05 at 2 48 10 PM

go test --json output:

{"Time":"2021-10-04T12:37:26.461544593-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath"}
{"Time":"2021-10-04T12:37:26.461704685-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath","Output":"=== RUN   TestCovCorHappyPath\n"}
{"Time":"2021-10-04T12:37:26.461725467-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/acop[INT-COVCOR-001]"}
{"Time":"2021-10-04T12:37:26.461730407-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/acop[INT-COVCOR-001]","Output":"=== RUN   TestCovCorHappyPath/acop[INT-COVCOR-001]\n"}
{"Time":"2021-10-04T12:37:26.472173964-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/example2_itsimp[INT-COVCOR-001]"}
{"Time":"2021-10-04T12:37:26.472198936-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/example2_itsimp[INT-COVCOR-001]","Output":"=== RUN   TestCovCorHappyPath/example2_itsimp[INT-COVCOR-001]\n"}
{"Time":"2021-10-04T12:37:26.480077335-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/1001[INT-COVCOR-001]"}
{"Time":"2021-10-04T12:37:26.480105842-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/1001[INT-COVCOR-001]","Output":"=== RUN   TestCovCorHappyPath/1001[INT-COVCOR-001]\n"}
{"Time":"2021-10-04T12:37:26.49009064-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath","Output":"--- PASS: TestCovCorHappyPath (0.03s)\n"}
{"Time":"2021-10-04T12:37:26.49012314-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/acop[INT-COVCOR-001]","Output":"    --- PASS: TestCovCorHappyPath/acop[INT-COVCOR-001] (0.01s)\n"}
{"Time":"2021-10-04T12:37:26.490130543-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/acop[INT-COVCOR-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:37:26.490138921-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/example2_itsimp[INT-COVCOR-001]","Output":"    --- PASS: TestCovCorHappyPath/example2_itsimp[INT-COVCOR-001] (0.01s)\n"}
{"Time":"2021-10-04T12:37:26.490145421-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/example2_itsimp[INT-COVCOR-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:37:26.490149957-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/1001[INT-COVCOR-001]","Output":"    --- PASS: TestCovCorHappyPath/1001[INT-COVCOR-001] (0.01s)\n"}
{"Time":"2021-10-04T12:37:26.490154897-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath/1001[INT-COVCOR-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:37:26.490159036-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorHappyPath","Elapsed":0.03}
{"Time":"2021-10-04T12:37:26.490163142-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors"}
{"Time":"2021-10-04T12:37:26.490168138-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors","Output":"=== RUN   TestCovCorErrors\n"}
{"Time":"2021-10-04T12:37:26.490172961-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/12[INT-COVCOR-002]"}
{"Time":"2021-10-04T12:37:26.490177057-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/12[INT-COVCOR-002]","Output":"=== RUN   TestCovCorErrors/12[INT-COVCOR-002]\n"}
{"Time":"2021-10-04T12:37:26.504330072-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/iovmm[INT-COVCOR-002]"}
{"Time":"2021-10-04T12:37:26.504351592-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/iovmm[INT-COVCOR-002]","Output":"=== RUN   TestCovCorErrors/iovmm[INT-COVCOR-002]\n"}
{"Time":"2021-10-04T12:37:26.527975785-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors","Output":"--- PASS: TestCovCorErrors (0.03s)\n"}
{"Time":"2021-10-04T12:37:26.527998086-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/12[INT-COVCOR-002]","Output":"    --- PASS: TestCovCorErrors/12[INT-COVCOR-002] (0.01s)\n"}
{"Time":"2021-10-04T12:37:26.528004721-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/12[INT-COVCOR-002]","Elapsed":0.01}
{"Time":"2021-10-04T12:37:26.528014526-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/iovmm[INT-COVCOR-002]","Output":"    --- PASS: TestCovCorErrors/iovmm[INT-COVCOR-002] (0.02s)\n"}
{"Time":"2021-10-04T12:37:26.528022646-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors/iovmm[INT-COVCOR-002]","Elapsed":0.02}
{"Time":"2021-10-04T12:37:26.528027079-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestCovCorErrors","Elapsed":0.03}
{"Time":"2021-10-04T12:37:26.528031328-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix"}
{"Time":"2021-10-04T12:37:26.528036184-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix","Output":"=== RUN   TestBBIExpandsWithoutPrefix\n"}
{"Time":"2021-10-04T12:37:26.528045516-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]"}
{"Time":"2021-10-04T12:37:26.528049279-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]","Output":"=== RUN   TestBBIExpandsWithoutPrefix/[INT-EXP-001]\n"}
{"Time":"2021-10-04T12:37:26.52805371-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]","Output":"    bbi_expansion_test.go:24: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:38:04.539044297-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/101.ctl[INT-EXP-001]"}
{"Time":"2021-10-04T12:38:04.539069656-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/101.ctl[INT-EXP-001]","Output":"=== RUN   TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/101.ctl[INT-EXP-001]\n"}
{"Time":"2021-10-04T12:38:04.539277177-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/102.ctl[INT-EXP-001]"}
{"Time":"2021-10-04T12:38:04.539285909-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/102.ctl[INT-EXP-001]","Output":"=== RUN   TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/102.ctl[INT-EXP-001]\n"}
{"Time":"2021-10-04T12:38:04.539499522-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/103.ctl[INT-EXP-001]"}
{"Time":"2021-10-04T12:38:04.539509143-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/103.ctl[INT-EXP-001]","Output":"=== RUN   TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/103.ctl[INT-EXP-001]\n"}
{"Time":"2021-10-04T12:38:04.53971336-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/104.ctl[INT-EXP-001]"}
{"Time":"2021-10-04T12:38:04.539721721-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/104.ctl[INT-EXP-001]","Output":"=== RUN   TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/104.ctl[INT-EXP-001]\n"}
{"Time":"2021-10-04T12:38:04.53990704-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/105.ctl[INT-EXP-001]"}
{"Time":"2021-10-04T12:38:04.539926159-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/105.ctl[INT-EXP-001]","Output":"=== RUN   TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/105.ctl[INT-EXP-001]\n"}
{"Time":"2021-10-04T12:38:04.540164632-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix","Output":"--- PASS: TestBBIExpandsWithoutPrefix (38.02s)\n"}
{"Time":"2021-10-04T12:38:04.540175447-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]","Output":"    --- PASS: TestBBIExpandsWithoutPrefix/[INT-EXP-001] (38.02s)\n"}
{"Time":"2021-10-04T12:38:04.540182652-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/101.ctl[INT-EXP-001]","Output":"        --- PASS: TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/101.ctl[INT-EXP-001] (0.00s)\n"}
{"Time":"2021-10-04T12:38:04.540188022-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/101.ctl[INT-EXP-001]","Elapsed":0}
{"Time":"2021-10-04T12:38:04.540194852-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/102.ctl[INT-EXP-001]","Output":"        --- PASS: TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/102.ctl[INT-EXP-001] (0.00s)\n"}
{"Time":"2021-10-04T12:38:04.540199992-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/102.ctl[INT-EXP-001]","Elapsed":0}
{"Time":"2021-10-04T12:38:04.540205101-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/103.ctl[INT-EXP-001]","Output":"        --- PASS: TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/103.ctl[INT-EXP-001] (0.00s)\n"}
{"Time":"2021-10-04T12:38:04.540221257-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/103.ctl[INT-EXP-001]","Elapsed":0}
{"Time":"2021-10-04T12:38:04.540230898-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/104.ctl[INT-EXP-001]","Output":"        --- PASS: TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/104.ctl[INT-EXP-001] (0.00s)\n"}
{"Time":"2021-10-04T12:38:04.540237312-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/104.ctl[INT-EXP-001]","Elapsed":0}
{"Time":"2021-10-04T12:38:04.54024249-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/105.ctl[INT-EXP-001]","Output":"        --- PASS: TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/105.ctl[INT-EXP-001] (0.00s)\n"}
{"Time":"2021-10-04T12:38:04.540249989-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]//data/762/working/bbi_expansion/model/105.ctl[INT-EXP-001]","Elapsed":0}
{"Time":"2021-10-04T12:38:04.540254618-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix/[INT-EXP-001]","Elapsed":38.02}
{"Time":"2021-10-04T12:38:04.540263982-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithoutPrefix","Elapsed":38.02}
{"Time":"2021-10-04T12:38:04.540269178-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix"}
{"Time":"2021-10-04T12:38:04.540274152-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix","Output":"=== RUN   TestBBIExpandsWithPrefix\n"}
{"Time":"2021-10-04T12:38:04.540279981-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]"}
{"Time":"2021-10-04T12:38:04.540287113-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]","Output":"=== RUN   TestBBIExpandsWithPrefix/[INT-EXP-002]\n"}
{"Time":"2021-10-04T12:38:04.540292273-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]","Output":"    bbi_expansion_test.go:92: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:38:27.346994328-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_101.ctl[INT-EXP-002]"}
{"Time":"2021-10-04T12:38:27.347022225-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_101.ctl[INT-EXP-002]","Output":"=== RUN   TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_101.ctl[INT-EXP-002]\n"}
{"Time":"2021-10-04T12:38:27.34726144-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl[INT-EXP-002]"}
{"Time":"2021-10-04T12:38:27.347272068-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl[INT-EXP-002]","Output":"=== RUN   TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl[INT-EXP-002]\n"}
{"Time":"2021-10-04T12:38:27.347488182-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl[INT-EXP-002]"}
{"Time":"2021-10-04T12:38:27.347497481-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl[INT-EXP-002]","Output":"=== RUN   TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl[INT-EXP-002]\n"}
{"Time":"2021-10-04T12:38:27.347697592-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix","Output":"--- PASS: TestBBIExpandsWithPrefix (22.81s)\n"}
{"Time":"2021-10-04T12:38:27.347707947-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]","Output":"    --- PASS: TestBBIExpandsWithPrefix/[INT-EXP-002] (22.81s)\n"}
{"Time":"2021-10-04T12:38:27.347715074-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_101.ctl[INT-EXP-002]","Output":"        --- PASS: TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_101.ctl[INT-EXP-002] (0.00s)\n"}
{"Time":"2021-10-04T12:38:27.347727412-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_101.ctl[INT-EXP-002]","Elapsed":0}
{"Time":"2021-10-04T12:38:27.347733808-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl[INT-EXP-002]","Output":"        --- PASS: TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl[INT-EXP-002] (0.00s)\n"}
{"Time":"2021-10-04T12:38:27.34773911-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl[INT-EXP-002]","Elapsed":0}
{"Time":"2021-10-04T12:38:27.347746194-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl[INT-EXP-002]","Output":"        --- PASS: TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl[INT-EXP-002] (0.00s)\n"}
{"Time":"2021-10-04T12:38:27.347753715-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl[INT-EXP-002]","Elapsed":0}
{"Time":"2021-10-04T12:38:27.34775853-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix/[INT-EXP-002]","Elapsed":22.81}
{"Time":"2021-10-04T12:38:27.347768978-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefix","Elapsed":22.81}
{"Time":"2021-10-04T12:38:27.347774604-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch"}
{"Time":"2021-10-04T12:38:27.347778384-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch","Output":"=== RUN   TestBBIExpandsWithPrefixToPartialMatch\n"}
{"Time":"2021-10-04T12:38:27.347783432-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]"}
{"Time":"2021-10-04T12:38:27.347787799-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]","Output":"=== RUN   TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]\n"}
{"Time":"2021-10-04T12:38:27.347794262-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]","Output":"    bbi_expansion_test.go:161: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:38:41.907638418-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl"}
{"Time":"2021-10-04T12:38:41.907669627-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl","Output":"=== RUN   TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl\n"}
{"Time":"2021-10-04T12:38:41.907677267-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl"}
{"Time":"2021-10-04T12:38:41.907681751-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl","Output":"=== RUN   TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl\n"}
{"Time":"2021-10-04T12:38:41.907690442-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch","Output":"--- PASS: TestBBIExpandsWithPrefixToPartialMatch (14.56s)\n"}
{"Time":"2021-10-04T12:38:41.907699595-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]","Output":"    --- PASS: TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003] (14.56s)\n"}
{"Time":"2021-10-04T12:38:41.907707286-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl","Output":"        --- PASS: TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl (0.00s)\n"}
{"Time":"2021-10-04T12:38:41.907716159-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_102.ctl","Elapsed":0}
{"Time":"2021-10-04T12:38:41.907725892-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl","Output":"        --- PASS: TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl (0.00s)\n"}
{"Time":"2021-10-04T12:38:41.907730543-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]//data/762/working/bbi_expansion/model/bbi_mainrun_103.ctl","Elapsed":0}
{"Time":"2021-10-04T12:38:41.907733899-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch/bbi_expansion[INT-EXP-003]","Elapsed":14.56}
{"Time":"2021-10-04T12:38:41.907739479-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIExpandsWithPrefixToPartialMatch","Elapsed":14.56}
{"Time":"2021-10-04T12:38:41.907742979-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution"}
{"Time":"2021-10-04T12:38:41.907747402-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution","Output":"=== RUN   TestBbiCompletesLocalExecution\n"}
{"Time":"2021-10-04T12:38:41.907751573-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]"}
{"Time":"2021-10-04T12:38:41.907755769-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]","Output":"=== RUN   TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]\n"}
{"Time":"2021-10-04T12:38:41.907760095-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]","Output":"    bbi_local_test.go:32: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:38:41.921564524-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]/acop"}
{"Time":"2021-10-04T12:38:41.921589292-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]/acop","Output":"=== RUN   TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]/acop\n"}
{"Time":"2021-10-04T12:38:49.770590989-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001]"}
{"Time":"2021-10-04T12:38:49.770616616-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001]","Output":"=== RUN   TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001]\n"}
{"Time":"2021-10-04T12:38:49.77062549-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001]","Output":"    bbi_local_test.go:32: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:38:49.787852018-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution","Output":"--- PASS: TestBbiCompletesLocalExecution (7.88s)\n"}
{"Time":"2021-10-04T12:38:49.787877452-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]","Output":"    --- PASS: TestBbiCompletesLocalExecution/acop[INT-LOCAL-001] (7.87s)\n"}
{"Time":"2021-10-04T12:38:49.787891349-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]/acop","Output":"        --- PASS: TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]/acop (7.85s)\n"}
{"Time":"2021-10-04T12:38:49.787896939-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]/acop","Elapsed":7.85}
{"Time":"2021-10-04T12:38:49.787959942-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/acop[INT-LOCAL-001]","Elapsed":7.87}
{"Time":"2021-10-04T12:38:49.787969234-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001]","Output":"    --- PASS: TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001] (0.02s)\n"}
{"Time":"2021-10-04T12:38:49.787975589-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution/metrum_std[INT-LOCAL-001]","Elapsed":0.02}
{"Time":"2021-10-04T12:38:49.787981105-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesLocalExecution","Elapsed":7.88}
{"Time":"2021-10-04T12:38:49.787990668-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript"}
{"Time":"2021-10-04T12:38:49.788008249-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript","Output":"=== RUN   TestNMFEOptionsEndInScript\n"}
{"Time":"2021-10-04T12:38:49.788016103-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]"}
{"Time":"2021-10-04T12:38:49.788019329-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]","Output":"=== RUN   TestNMFEOptionsEndInScript/240[INT-LOCAL-002]\n"}
{"Time":"2021-10-04T12:38:49.788023329-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]","Output":"    bbi_local_test.go:91: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:38:49.803041867-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]/Executable_MTP"}
{"Time":"2021-10-04T12:38:49.803059897-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]/Executable_MTP","Output":"=== RUN   TestNMFEOptionsEndInScript/240[INT-LOCAL-002]/Executable_MTP\n"}
{"Time":"2021-10-04T12:39:04.205193835-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]"}
{"Time":"2021-10-04T12:39:04.205233644-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]","Output":"=== RUN   TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]\n"}
{"Time":"2021-10-04T12:39:04.205241513-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]","Output":"    bbi_local_test.go:91: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:39:04.217273822-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]/acop"}
{"Time":"2021-10-04T12:39:04.217303763-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]/acop","Output":"=== RUN   TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]/acop\n"}
{"Time":"2021-10-04T12:39:18.426161867-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]"}
{"Time":"2021-10-04T12:39:18.426193852-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]","Output":"=== RUN   TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]\n"}
{"Time":"2021-10-04T12:39:18.426204241-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]","Output":"    bbi_local_test.go:91: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:39:18.447157556-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]/Executable_MTP"}
{"Time":"2021-10-04T12:39:18.447183737-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]/Executable_MTP","Output":"=== RUN   TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]/Executable_MTP\n"}
{"Time":"2021-10-04T12:39:32.704420612-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002]"}
{"Time":"2021-10-04T12:39:32.704449398-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002]","Output":"=== RUN   TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002]\n"}
{"Time":"2021-10-04T12:39:32.7044609-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002]","Output":"    bbi_local_test.go:91: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:39:32.736807296-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript","Output":"--- PASS: TestNMFEOptionsEndInScript (42.95s)\n"}
{"Time":"2021-10-04T12:39:32.736841922-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]","Output":"    --- PASS: TestNMFEOptionsEndInScript/240[INT-LOCAL-002] (14.41s)\n"}
{"Time":"2021-10-04T12:39:32.736851026-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]/Executable_MTP","Output":"        --- PASS: TestNMFEOptionsEndInScript/240[INT-LOCAL-002]/Executable_MTP (14.40s)\n"}
{"Time":"2021-10-04T12:39:32.736858536-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]/Executable_MTP","Elapsed":14.4}
{"Time":"2021-10-04T12:39:32.736866813-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/240[INT-LOCAL-002]","Elapsed":14.41}
{"Time":"2021-10-04T12:39:32.736872886-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]","Output":"    --- PASS: TestNMFEOptionsEndInScript/acop[INT-LOCAL-002] (14.23s)\n"}
{"Time":"2021-10-04T12:39:32.736878816-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]/acop","Output":"        --- PASS: TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]/acop (14.21s)\n"}
{"Time":"2021-10-04T12:39:32.736884246-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]/acop","Elapsed":14.21}
{"Time":"2021-10-04T12:39:32.736888783-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/acop[INT-LOCAL-002]","Elapsed":14.23}
{"Time":"2021-10-04T12:39:32.736893211-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]","Output":"    --- PASS: TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002] (14.28s)\n"}
{"Time":"2021-10-04T12:39:32.736898567-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]/Executable_MTP","Output":"        --- PASS: TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]/Executable_MTP (14.26s)\n"}
{"Time":"2021-10-04T12:39:32.736903852-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]/Executable_MTP","Elapsed":14.26}
{"Time":"2021-10-04T12:39:32.736908112-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/ctl_test[INT-LOCAL-002]","Elapsed":14.28}
{"Time":"2021-10-04T12:39:32.736912409-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002]","Output":"    --- PASS: TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002] (0.03s)\n"}
{"Time":"2021-10-04T12:39:32.736918027-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript/metrum_std[INT-LOCAL-002]","Elapsed":0.03}
{"Time":"2021-10-04T12:39:32.736922074-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMFEOptionsEndInScript","Elapsed":42.95}
{"Time":"2021-10-04T12:39:32.736926882-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution"}
{"Time":"2021-10-04T12:39:32.736931946-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution","Output":"=== RUN   TestBbiParallelExecution\n"}
{"Time":"2021-10-04T12:39:32.736941343-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]"}
{"Time":"2021-10-04T12:39:32.7369456-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]","Output":"=== RUN   TestBbiParallelExecution/240[INT-LOCAL-003]\n"}
{"Time":"2021-10-04T12:39:32.736951039-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]","Output":"    bbi_local_test.go:160: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:39:32.758640563-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]/Executable_MTP"}
{"Time":"2021-10-04T12:39:32.758669437-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]/Executable_MTP","Output":"=== RUN   TestBbiParallelExecution/240[INT-LOCAL-003]/Executable_MTP\n"}
{"Time":"2021-10-04T12:39:44.933059709-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]"}
{"Time":"2021-10-04T12:39:44.933090171-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]","Output":"=== RUN   TestBbiParallelExecution/acop[INT-LOCAL-003]\n"}
{"Time":"2021-10-04T12:39:44.933098634-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]","Output":"    bbi_local_test.go:160: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:39:45.002088475-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]/acop"}
{"Time":"2021-10-04T12:39:45.002116174-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]/acop","Output":"=== RUN   TestBbiParallelExecution/acop[INT-LOCAL-003]/acop\n"}
{"Time":"2021-10-04T12:39:59.293389438-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]"}
{"Time":"2021-10-04T12:39:59.293417856-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]","Output":"=== RUN   TestBbiParallelExecution/ctl_test[INT-LOCAL-003]\n"}
{"Time":"2021-10-04T12:39:59.293424884-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]","Output":"    bbi_local_test.go:160: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:39:59.372065704-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]/Executable_MTP"}
{"Time":"2021-10-04T12:39:59.372098902-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]/Executable_MTP","Output":"=== RUN   TestBbiParallelExecution/ctl_test[INT-LOCAL-003]/Executable_MTP\n"}
{"Time":"2021-10-04T12:40:13.477864614-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/metrum_std[INT-LOCAL-003]"}
{"Time":"2021-10-04T12:40:13.477892136-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/metrum_std[INT-LOCAL-003]","Output":"=== RUN   TestBbiParallelExecution/metrum_std[INT-LOCAL-003]\n"}
{"Time":"2021-10-04T12:40:13.477901844-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/metrum_std[INT-LOCAL-003]","Output":"    bbi_local_test.go:160: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:40:13.542910595-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution","Output":"--- PASS: TestBbiParallelExecution (40.81s)\n"}
{"Time":"2021-10-04T12:40:13.542946874-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]","Output":"    --- PASS: TestBbiParallelExecution/240[INT-LOCAL-003] (12.19s)\n"}
{"Time":"2021-10-04T12:40:13.542957623-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]/Executable_MTP","Output":"        --- PASS: TestBbiParallelExecution/240[INT-LOCAL-003]/Executable_MTP (12.17s)\n"}
{"Time":"2021-10-04T12:40:13.542964083-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]/Executable_MTP","Elapsed":12.17}
{"Time":"2021-10-04T12:40:13.542972045-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/240[INT-LOCAL-003]","Elapsed":12.19}
{"Time":"2021-10-04T12:40:13.542976879-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]","Output":"    --- PASS: TestBbiParallelExecution/acop[INT-LOCAL-003] (14.36s)\n"}
{"Time":"2021-10-04T12:40:13.542982354-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]/acop","Output":"        --- PASS: TestBbiParallelExecution/acop[INT-LOCAL-003]/acop (14.29s)\n"}
{"Time":"2021-10-04T12:40:13.542987066-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]/acop","Elapsed":14.29}
{"Time":"2021-10-04T12:40:13.542991114-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/acop[INT-LOCAL-003]","Elapsed":14.36}
{"Time":"2021-10-04T12:40:13.542995278-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]","Output":"    --- PASS: TestBbiParallelExecution/ctl_test[INT-LOCAL-003] (14.18s)\n"}
{"Time":"2021-10-04T12:40:13.543000407-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]/Executable_MTP","Output":"        --- PASS: TestBbiParallelExecution/ctl_test[INT-LOCAL-003]/Executable_MTP (14.11s)\n"}
{"Time":"2021-10-04T12:40:13.543005485-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]/Executable_MTP","Elapsed":14.11}
{"Time":"2021-10-04T12:40:13.543009423-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/ctl_test[INT-LOCAL-003]","Elapsed":14.18}
{"Time":"2021-10-04T12:40:13.543013566-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/metrum_std[INT-LOCAL-003]","Output":"    --- PASS: TestBbiParallelExecution/metrum_std[INT-LOCAL-003] (0.07s)\n"}
{"Time":"2021-10-04T12:40:13.543019132-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution/metrum_std[INT-LOCAL-003]","Elapsed":0.07}
{"Time":"2021-10-04T12:40:13.543023258-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiParallelExecution","Elapsed":40.81}
{"Time":"2021-10-04T12:40:13.54302815-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded"}
{"Time":"2021-10-04T12:40:13.543033176-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded","Output":"=== RUN   TestDefaultConfigLoaded\n"}
{"Time":"2021-10-04T12:40:13.543040111-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]"}
{"Time":"2021-10-04T12:40:13.543046623-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]","Output":"=== RUN   TestDefaultConfigLoaded/240[INT-LOCAL-004]\n"}
{"Time":"2021-10-04T12:40:13.543051202-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]","Output":"    bbi_local_test.go:222: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:40:13.611496367-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]/Executable_MTP"}
{"Time":"2021-10-04T12:40:13.611523043-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]/Executable_MTP","Output":"=== RUN   TestDefaultConfigLoaded/240[INT-LOCAL-004]/Executable_MTP\n"}
{"Time":"2021-10-04T12:40:23.270017541-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded","Output":"--- PASS: TestDefaultConfigLoaded (9.73s)\n"}
{"Time":"2021-10-04T12:40:23.270052588-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]","Output":"    --- PASS: TestDefaultConfigLoaded/240[INT-LOCAL-004] (9.73s)\n"}
{"Time":"2021-10-04T12:40:23.270060224-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]/Executable_MTP","Output":"        --- PASS: TestDefaultConfigLoaded/240[INT-LOCAL-004]/Executable_MTP (9.66s)\n"}
{"Time":"2021-10-04T12:40:23.270065742-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]/Executable_MTP","Elapsed":9.66}
{"Time":"2021-10-04T12:40:23.270073795-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded/240[INT-LOCAL-004]","Elapsed":9.73}
{"Time":"2021-10-04T12:40:23.270078105-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestDefaultConfigLoaded","Elapsed":9.73}
{"Time":"2021-10-04T12:40:23.27008257-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded"}
{"Time":"2021-10-04T12:40:23.270087016-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded","Output":"=== RUN   TestSpecifiedConfigByAbsPathLoaded\n"}
{"Time":"2021-10-04T12:40:23.270103266-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/[INT-LOCAL-005]"}
{"Time":"2021-10-04T12:40:23.270107502-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/[INT-LOCAL-005]","Output":"=== RUN   TestSpecifiedConfigByAbsPathLoaded/[INT-LOCAL-005]\n"}
{"Time":"2021-10-04T12:40:23.270182353-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]"}
{"Time":"2021-10-04T12:40:23.270193632-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]","Output":"=== RUN   TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]\n"}
{"Time":"2021-10-04T12:40:23.270215089-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]","Output":"    bbi_local_test.go:292: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:40:23.288711759-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP"}
{"Time":"2021-10-04T12:40:23.288732503-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"=== RUN   TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP\n"}
{"Time":"2021-10-04T12:40:23.293625086-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"time=\"2021-10-04T12:40:23-04:00\" level=info msg=\"Command was 'bbi' while arguments were -d --config /data/762/meow/bbi.yaml nonmem run local --nm_version nm74gf /data/762/working/240/Executable_MTP.mod\"\n"}
{"Time":"2021-10-04T12:40:23.293644321-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"time=\"2021-10-04T12:40:23-04:00\" level=error msg=\"An error occurred trying to execute model. Error details are : exit status 1\"\n"}
{"Time":"2021-10-04T12:40:23.29365263-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"time=\"2021-10-04T12:40:23-04:00\" level=error msg=\"Exit code was 1, details were exit status 1\"\n"}
{"Time":"2021-10-04T12:40:23.293694324-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"time=\"2021-10-04T12:40:23-04:00\" level=error msg=\"output details were: time=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Successfully loaded specified configuration from /data/762/meow/bbi.yaml\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Beginning Local Path\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Setting logging to DEBUG\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Locating models from arguments\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"A total of 1 models have completed the initial preparation phase\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Building turnstile manager\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Beginning turnstile execution\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Manager Details: Working: 0, Errors: 0, Completed: 0, Concurrency: 4, Iterations: 1\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] Beginning local preparation phase\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug "}
{"Time":"2021-10-04T12:40:23.293709556-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"msg=\\\"[Executable_MTP] Overwrite is currently set to true\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] Writing initial gitignore file\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Requested save of config file /data/762/working/240/Executable_MTP\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] Creating local execution script\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] beginning script command generation. NMQual is set to false\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=fatal msg=\\\"nmVersion of  was provided but has no configurations in bbi.yaml!\\\"\\n\"\n"}
{"Time":"2021-10-04T12:40:23.293784609-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded","Output":"--- PASS: TestSpecifiedConfigByAbsPathLoaded (0.02s)\n"}
{"Time":"2021-10-04T12:40:23.293796221-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/[INT-LOCAL-005]","Output":"    --- PASS: TestSpecifiedConfigByAbsPathLoaded/[INT-LOCAL-005] (0.00s)\n"}
{"Time":"2021-10-04T12:40:23.293801543-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/[INT-LOCAL-005]","Elapsed":0}
{"Time":"2021-10-04T12:40:23.29380833-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]","Output":"    --- PASS: TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005] (0.02s)\n"}
{"Time":"2021-10-04T12:40:23.29381427-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Output":"        --- PASS: TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP (0.01s)\n"}
{"Time":"2021-10-04T12:40:23.293825046-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]/Executable_MTP","Elapsed":0.01}
{"Time":"2021-10-04T12:40:23.293834079-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded/240[INT-LOCAL-005]","Elapsed":0.02}
{"Time":"2021-10-04T12:40:23.293838758-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByAbsPathLoaded","Elapsed":0.02}
{"Time":"2021-10-04T12:40:23.29384307-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded"}
{"Time":"2021-10-04T12:40:23.293847248-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded","Output":"=== RUN   TestSpecifiedConfigByRelativePathLoaded\n"}
{"Time":"2021-10-04T12:40:23.293853632-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]"}
{"Time":"2021-10-04T12:40:23.293857655-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]","Output":"=== RUN   TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]\n"}
{"Time":"2021-10-04T12:40:23.293959601-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]","Output":"    bbi_local_test.go:347: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:40:23.308502914-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]"}
{"Time":"2021-10-04T12:40:23.308521285-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"=== RUN   TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]\n"}
{"Time":"2021-10-04T12:40:23.31622967-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"time=\"2021-10-04T12:40:23-04:00\" level=info msg=\"Command was 'bbi' while arguments were -d --config /data/762/meow/bbi.yaml nonmem run local --nm_version nm74gf /data/762/working/240/Executable_MTP.mod\"\n"}
{"Time":"2021-10-04T12:40:23.316249998-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"time=\"2021-10-04T12:40:23-04:00\" level=error msg=\"An error occurred trying to execute model. Error details are : exit status 1\"\n"}
{"Time":"2021-10-04T12:40:23.316261217-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"time=\"2021-10-04T12:40:23-04:00\" level=error msg=\"Exit code was 1, details were exit status 1\"\n"}
{"Time":"2021-10-04T12:40:23.316308945-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"time=\"2021-10-04T12:40:23-04:00\" level=error msg=\"output details were: time=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Successfully loaded specified configuration from /data/762/meow/bbi.yaml\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Beginning Local Path\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Setting logging to DEBUG\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Locating models from arguments\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"A total of 1 models have completed the initial preparation phase\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Building turnstile manager\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Beginning turnstile execution\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=info msg=\\\"Manager Details: Working: 0, Errors: 0, Completed: 0, Concurrency: 4, Iterations: 1\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] Beginning local preparation phase\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug "}
{"Time":"2021-10-04T12:40:23.316322628-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"msg=\\\"[Executable_MTP] Overwrite is currently set to true\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] Writing initial gitignore file\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"Requested save of config file /data/762/working/240/Executable_MTP\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] Creating local execution script\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=debug msg=\\\"[Executable_MTP] beginning script command generation. NMQual is set to false\\\"\\ntime=\\\"2021-10-04T12:40:23-04:00\\\" level=fatal msg=\\\"nmVersion of  was provided but has no configurations in bbi.yaml!\\\"\\n\"\n"}
{"Time":"2021-10-04T12:40:23.316338913-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded","Output":"--- PASS: TestSpecifiedConfigByRelativePathLoaded (0.02s)\n"}
{"Time":"2021-10-04T12:40:23.316346509-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]","Output":"    --- PASS: TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006] (0.02s)\n"}
{"Time":"2021-10-04T12:40:23.316352617-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Output":"        --- PASS: TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006] (0.01s)\n"}
{"Time":"2021-10-04T12:40:23.316359077-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]/Executable_MTP[INT-LOCAL-006]","Elapsed":0.01}
{"Time":"2021-10-04T12:40:23.316365039-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded/[INT-LOCAL-006]","Elapsed":0.02}
{"Time":"2021-10-04T12:40:23.316381034-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSpecifiedConfigByRelativePathLoaded","Elapsed":0.02}
{"Time":"2021-10-04T12:40:23.31638561-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution"}
{"Time":"2021-10-04T12:40:23.316389848-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution","Output":"=== RUN   TestBbiCompletesSGEExecution\n"}
{"Time":"2021-10-04T12:40:23.316397013-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]"}
{"Time":"2021-10-04T12:40:23.31640168-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]","Output":"=== RUN   TestBbiCompletesSGEExecution/acop[INT-SGE-001]\n"}
{"Time":"2021-10-04T12:40:23.316431406-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]","Output":"    bbi_sge_test.go:35: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:40:23.33301767-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop"}
{"Time":"2021-10-04T12:40:23.333032783-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop","Output":"=== RUN   TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop\n"}
{"Time":"2021-10-04T12:40:23.347029063-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop","Output":"time=\"2021-10-04T12:40:23-04:00\" level=info msg=\"Provided value for location job by name was : drone_762_Run_acop\"\n"}
{"Time":"2021-10-04T12:40:23.355231706-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop","Output":"time=\"2021-10-04T12:40:23-04:00\" level=info msg=\"Located 1 pending jobs. Waiting for 30 seconds to check again\"\n"}
{"Time":"2021-10-04T12:40:53.35955808-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop","Output":"time=\"2021-10-04T12:40:53-04:00\" level=info msg=\"Looks like all queued and running jobs have terminated\"\n"}
{"Time":"2021-10-04T12:40:53.359725817-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]"}
{"Time":"2021-10-04T12:40:53.359752316-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]","Output":"=== RUN   TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]\n"}
{"Time":"2021-10-04T12:40:53.359761308-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]","Output":"    bbi_sge_test.go:35: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:40:53.37582619-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP"}
{"Time":"2021-10-04T12:40:53.375856842-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP","Output":"=== RUN   TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP\n"}
{"Time":"2021-10-04T12:40:53.390239875-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP","Output":"time=\"2021-10-04T12:40:53-04:00\" level=info msg=\"Provided value for location job by name was : drone_762_Run_Executable_MTP\"\n"}
{"Time":"2021-10-04T12:40:53.39852925-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP","Output":"time=\"2021-10-04T12:40:53-04:00\" level=info msg=\"Located 1 pending jobs. Waiting for 30 seconds to check again\"\n"}
{"Time":"2021-10-04T12:41:23.403038735-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP","Output":"time=\"2021-10-04T12:41:23-04:00\" level=info msg=\"Looks like all queued and running jobs have terminated\"\n"}
{"Time":"2021-10-04T12:41:23.403219351-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution","Output":"--- PASS: TestBbiCompletesSGEExecution (60.09s)\n"}
{"Time":"2021-10-04T12:41:23.403244151-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]","Output":"    --- PASS: TestBbiCompletesSGEExecution/acop[INT-SGE-001] (30.04s)\n"}
{"Time":"2021-10-04T12:41:23.403251149-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop","Output":"        --- PASS: TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop (30.03s)\n"}
{"Time":"2021-10-04T12:41:23.403256361-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]/acop","Elapsed":30.03}
{"Time":"2021-10-04T12:41:23.403266185-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/acop[INT-SGE-001]","Elapsed":30.04}
{"Time":"2021-10-04T12:41:23.403270778-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]","Output":"    --- PASS: TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001] (30.04s)\n"}
{"Time":"2021-10-04T12:41:23.403286237-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP","Output":"        --- PASS: TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP (30.03s)\n"}
{"Time":"2021-10-04T12:41:23.403293556-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]/Executable_MTP","Elapsed":30.03}
{"Time":"2021-10-04T12:41:23.403297826-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution/ctl_test[INT-SGE-001]","Elapsed":30.04}
{"Time":"2021-10-04T12:41:23.403301501-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesSGEExecution","Elapsed":60.09}
{"Time":"2021-10-04T12:41:23.403305944-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution"}
{"Time":"2021-10-04T12:41:23.403310609-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution","Output":"=== RUN   TestBbiCompletesParallelSGEExecution\n"}
{"Time":"2021-10-04T12:41:23.403315826-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]"}
{"Time":"2021-10-04T12:41:23.403321426-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]","Output":"=== RUN   TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]\n"}
{"Time":"2021-10-04T12:41:23.403325621-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]","Output":"    bbi_sge_test.go:92: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:41:23.418618755-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP"}
{"Time":"2021-10-04T12:41:23.418641058-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP","Output":"=== RUN   TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP\n"}
{"Time":"2021-10-04T12:41:23.428497092-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP","Output":"time=\"2021-10-04T12:41:23-04:00\" level=info msg=\"Provided value for location job by name was : drone_762_Run_Executable_MTP\"\n"}
{"Time":"2021-10-04T12:41:23.436277652-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP","Output":"time=\"2021-10-04T12:41:23-04:00\" level=info msg=\"Located 1 pending jobs. Waiting for 30 seconds to check again\"\n"}
{"Time":"2021-10-04T12:41:53.440974255-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP","Output":"time=\"2021-10-04T12:41:53-04:00\" level=info msg=\"Looks like all queued and running jobs have terminated\"\n"}
{"Time":"2021-10-04T12:41:53.441358373-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]"}
{"Time":"2021-10-04T12:41:53.441383103-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]","Output":"=== RUN   TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]\n"}
{"Time":"2021-10-04T12:41:53.441390702-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]","Output":"    bbi_sge_test.go:92: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:41:53.458852025-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop"}
{"Time":"2021-10-04T12:41:53.458884894-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop","Output":"=== RUN   TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop\n"}
{"Time":"2021-10-04T12:41:53.469118436-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop","Output":"time=\"2021-10-04T12:41:53-04:00\" level=info msg=\"Provided value for location job by name was : drone_762_Run_acop\"\n"}
{"Time":"2021-10-04T12:41:53.47682325-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop","Output":"time=\"2021-10-04T12:41:53-04:00\" level=info msg=\"Located 1 pending jobs. Waiting for 30 seconds to check again\"\n"}
{"Time":"2021-10-04T12:42:23.481343483-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop","Output":"time=\"2021-10-04T12:42:23-04:00\" level=info msg=\"Looks like all queued and running jobs have terminated\"\n"}
{"Time":"2021-10-04T12:42:23.481570425-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]"}
{"Time":"2021-10-04T12:42:23.481588338-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]","Output":"=== RUN   TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]\n"}
{"Time":"2021-10-04T12:42:23.481598884-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]","Output":"    bbi_sge_test.go:92: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:42:23.497542399-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP"}
{"Time":"2021-10-04T12:42:23.497569834-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP","Output":"=== RUN   TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP\n"}
{"Time":"2021-10-04T12:42:23.507388588-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP","Output":"time=\"2021-10-04T12:42:23-04:00\" level=info msg=\"Provided value for location job by name was : drone_762_Run_Executable_MTP\"\n"}
{"Time":"2021-10-04T12:42:23.514805444-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP","Output":"time=\"2021-10-04T12:42:23-04:00\" level=info msg=\"Located 1 pending jobs. Waiting for 30 seconds to check again\"\n"}
{"Time":"2021-10-04T12:42:53.519346012-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP","Output":"time=\"2021-10-04T12:42:53-04:00\" level=info msg=\"Looks like all queued and running jobs have terminated\"\n"}
{"Time":"2021-10-04T12:42:53.519969751-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution","Output":"--- PASS: TestBbiCompletesParallelSGEExecution (90.12s)\n"}
{"Time":"2021-10-04T12:42:53.519990438-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]","Output":"    --- PASS: TestBbiCompletesParallelSGEExecution/240[INT-SGE-002] (30.04s)\n"}
{"Time":"2021-10-04T12:42:53.519996509-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP","Output":"        --- PASS: TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP (30.02s)\n"}
{"Time":"2021-10-04T12:42:53.520001513-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]/Executable_MTP","Elapsed":30.02}
{"Time":"2021-10-04T12:42:53.520009548-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/240[INT-SGE-002]","Elapsed":30.04}
{"Time":"2021-10-04T12:42:53.52001397-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]","Output":"    --- PASS: TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002] (30.04s)\n"}
{"Time":"2021-10-04T12:42:53.520018805-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop","Output":"        --- PASS: TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop (30.02s)\n"}
{"Time":"2021-10-04T12:42:53.520023242-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]/acop","Elapsed":30.02}
{"Time":"2021-10-04T12:42:53.520032346-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/acop[INT-SGE-002]","Elapsed":30.04}
{"Time":"2021-10-04T12:42:53.520036524-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]","Output":"    --- PASS: TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002] (30.04s)\n"}
{"Time":"2021-10-04T12:42:53.520044818-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP","Output":"        --- PASS: TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP (30.02s)\n"}
{"Time":"2021-10-04T12:42:53.520100715-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]/Executable_MTP","Elapsed":30.02}
{"Time":"2021-10-04T12:42:53.520109504-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution/ctl_test[INT-SGE-002]","Elapsed":30.04}
{"Time":"2021-10-04T12:42:53.520113488-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBbiCompletesParallelSGEExecution","Elapsed":90.12}
{"Time":"2021-10-04T12:42:53.52011738-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath"}
{"Time":"2021-10-04T12:42:53.520122806-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath","Output":"=== RUN   TestSummaryHappyPath\n"}
{"Time":"2021-10-04T12:42:53.520127738-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.520132666-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/acop[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.520141904-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.520145821-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/acop[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.524120103-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.52413781-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/acop[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.527996485-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.528012297-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/12[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.528018745-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.52802155-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/12[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.532131176-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.532148005-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/12[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.536153741-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.536168962-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/example2_saemimp[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.536173431-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.536176308-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.540195626-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.540208619-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.544777883-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.544792002-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/example2_itsimp[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.544800007-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.54480436-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.549161596-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.54917519-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.55335897-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.553373306-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/example2_bayes[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.553379373-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.553382174-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.560142762-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.560155874-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.567388075-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.567402411-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/iovmm[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.567409819-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.567414267-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/iovmm[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.570889802-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.570908068-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/iovmm[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.574342413-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]"}
{"Time":"2021-10-04T12:42:53.57437302-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]","Output":"=== RUN   TestSummaryHappyPath/acop-iov[INT-SUM-001]\n"}
{"Time":"2021-10-04T12:42:53.574387088-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.json"}
{"Time":"2021-10-04T12:42:53.574396843-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.json","Output":"=== RUN   TestSummaryHappyPath/acop-iov[INT-SUM-001]/.json\n"}
{"Time":"2021-10-04T12:42:53.587239322-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.txt"}
{"Time":"2021-10-04T12:42:53.58725656-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.txt","Output":"=== RUN   TestSummaryHappyPath/acop-iov[INT-SUM-001]/.txt\n"}
{"Time":"2021-10-04T12:42:53.599488933-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath","Output":"--- PASS: TestSummaryHappyPath (0.08s)\n"}
{"Time":"2021-10-04T12:42:53.599506587-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/acop[INT-SUM-001] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599512756-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/acop[INT-SUM-001]/.json (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599517381-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.json","Elapsed":0}
{"Time":"2021-10-04T12:42:53.59952376-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/acop[INT-SUM-001]/.txt (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599528701-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]/.txt","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599532648-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop[INT-SUM-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599543567-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/12[INT-SUM-001] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599548755-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/12[INT-SUM-001]/.json (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599553641-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.json","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599558025-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/12[INT-SUM-001]/.txt (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599562654-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]/.txt","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599566435-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/12[INT-SUM-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599570636-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/example2_saemimp[INT-SUM-001] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599575116-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.json (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599579892-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.json","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599589241-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.txt (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599592655-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]/.txt","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599595279-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_saemimp[INT-SUM-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599599437-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/example2_itsimp[INT-SUM-001] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599604487-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.json (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599609332-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.json","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599618751-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.txt (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599623779-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]/.txt","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599627284-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_itsimp[INT-SUM-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599631427-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/example2_bayes[INT-SUM-001] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599636779-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.json (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599641915-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.json","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599646913-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.txt (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599651956-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]/.txt","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.59965627-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/example2_bayes[INT-SUM-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.59965992-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/iovmm[INT-SUM-001] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599665598-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/iovmm[INT-SUM-001]/.json (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599675997-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.json","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599679827-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/iovmm[INT-SUM-001]/.txt (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.599684205-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]/.txt","Elapsed":0}
{"Time":"2021-10-04T12:42:53.599687904-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/iovmm[INT-SUM-001]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599692326-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]","Output":"    --- PASS: TestSummaryHappyPath/acop-iov[INT-SUM-001] (0.03s)\n"}
{"Time":"2021-10-04T12:42:53.599704014-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.json","Output":"        --- PASS: TestSummaryHappyPath/acop-iov[INT-SUM-001]/.json (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599714282-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.json","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599723112-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.txt","Output":"        --- PASS: TestSummaryHappyPath/acop-iov[INT-SUM-001]/.txt (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.599728944-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]/.txt","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.599733478-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath/acop-iov[INT-SUM-001]","Elapsed":0.03}
{"Time":"2021-10-04T12:42:53.599737293-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPath","Elapsed":0.08}
{"Time":"2021-10-04T12:42:53.599741695-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs"}
{"Time":"2021-10-04T12:42:53.599746448-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs","Output":"=== RUN   TestSummaryArgs\n"}
{"Time":"2021-10-04T12:42:53.599753876-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]"}
{"Time":"2021-10-04T12:42:53.599757526-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]","Output":"=== RUN   TestSummaryArgs/66[INT-SUM-002]\n"}
{"Time":"2021-10-04T12:42:53.59976232-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.json"}
{"Time":"2021-10-04T12:42:53.599765736-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.json","Output":"=== RUN   TestSummaryArgs/66[INT-SUM-002]/.json\n"}
{"Time":"2021-10-04T12:42:53.605598052-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.txt"}
{"Time":"2021-10-04T12:42:53.605612381-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.txt","Output":"=== RUN   TestSummaryArgs/66[INT-SUM-002]/.txt\n"}
{"Time":"2021-10-04T12:42:53.61139768-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]"}
{"Time":"2021-10-04T12:42:53.611414311-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]","Output":"=== RUN   TestSummaryArgs/acop_no_grd[INT-SUM-002]\n"}
{"Time":"2021-10-04T12:42:53.611422986-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.json"}
{"Time":"2021-10-04T12:42:53.611428346-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.json","Output":"=== RUN   TestSummaryArgs/acop_no_grd[INT-SUM-002]/.json\n"}
{"Time":"2021-10-04T12:42:53.617712956-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.txt"}
{"Time":"2021-10-04T12:42:53.617726516-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.txt","Output":"=== RUN   TestSummaryArgs/acop_no_grd[INT-SUM-002]/.txt\n"}
{"Time":"2021-10-04T12:42:53.623793841-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]"}
{"Time":"2021-10-04T12:42:53.623809376-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]","Output":"=== RUN   TestSummaryArgs/1001[INT-SUM-002]\n"}
{"Time":"2021-10-04T12:42:53.623815845-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.json"}
{"Time":"2021-10-04T12:42:53.623818876-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.json","Output":"=== RUN   TestSummaryArgs/1001[INT-SUM-002]/.json\n"}
{"Time":"2021-10-04T12:42:53.662280557-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.txt"}
{"Time":"2021-10-04T12:42:53.662294703-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.txt","Output":"=== RUN   TestSummaryArgs/1001[INT-SUM-002]/.txt\n"}
{"Time":"2021-10-04T12:42:53.700152059-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs","Output":"--- PASS: TestSummaryArgs (0.10s)\n"}
{"Time":"2021-10-04T12:42:53.700169479-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]","Output":"    --- PASS: TestSummaryArgs/66[INT-SUM-002] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.70017578-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.json","Output":"        --- PASS: TestSummaryArgs/66[INT-SUM-002]/.json (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.700190306-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.json","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.700203713-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.txt","Output":"        --- PASS: TestSummaryArgs/66[INT-SUM-002]/.txt (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.700214273-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]/.txt","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.700218713-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/66[INT-SUM-002]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.700223451-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]","Output":"    --- PASS: TestSummaryArgs/acop_no_grd[INT-SUM-002] (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.700229125-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.json","Output":"        --- PASS: TestSummaryArgs/acop_no_grd[INT-SUM-002]/.json (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.700234303-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.json","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.700243834-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.txt","Output":"        --- PASS: TestSummaryArgs/acop_no_grd[INT-SUM-002]/.txt (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.700250578-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]/.txt","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.700254878-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/acop_no_grd[INT-SUM-002]","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.700262417-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]","Output":"    --- PASS: TestSummaryArgs/1001[INT-SUM-002] (0.08s)\n"}
{"Time":"2021-10-04T12:42:53.700271408-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.json","Output":"        --- PASS: TestSummaryArgs/1001[INT-SUM-002]/.json (0.04s)\n"}
{"Time":"2021-10-04T12:42:53.700277031-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.json","Elapsed":0.04}
{"Time":"2021-10-04T12:42:53.700281931-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.txt","Output":"        --- PASS: TestSummaryArgs/1001[INT-SUM-002]/.txt (0.04s)\n"}
{"Time":"2021-10-04T12:42:53.700287766-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]/.txt","Elapsed":0.04}
{"Time":"2021-10-04T12:42:53.700296299-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs/1001[INT-SUM-002]","Elapsed":0.08}
{"Time":"2021-10-04T12:42:53.700300634-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryArgs","Elapsed":0.1}
{"Time":"2021-10-04T12:42:53.700305922-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors"}
{"Time":"2021-10-04T12:42:53.700310548-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors","Output":"=== RUN   TestSummaryErrors\n"}
{"Time":"2021-10-04T12:42:53.700318552-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]"}
{"Time":"2021-10-04T12:42:53.700323103-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]","Output":"=== RUN   TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]\n"}
{"Time":"2021-10-04T12:42:53.702836765-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#01"}
{"Time":"2021-10-04T12:42:53.702855761-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#01","Output":"=== RUN   TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#01\n"}
{"Time":"2021-10-04T12:42:53.705372375-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#02"}
{"Time":"2021-10-04T12:42:53.705389045-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#02","Output":"=== RUN   TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#02\n"}
{"Time":"2021-10-04T12:42:53.707745444-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]"}
{"Time":"2021-10-04T12:42:53.707761992-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]","Output":"=== RUN   TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]\n"}
{"Time":"2021-10-04T12:42:53.710128997-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]#01"}
{"Time":"2021-10-04T12:42:53.710144925-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]#01","Output":"=== RUN   TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]#01\n"}
{"Time":"2021-10-04T12:42:53.712562618-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors","Output":"--- PASS: TestSummaryErrors (0.01s)\n"}
{"Time":"2021-10-04T12:42:53.712582856-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]","Output":"    --- PASS: TestSummaryErrors/no_such_file_or_directory[INT-SUM-003] (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.712588736-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]","Elapsed":0}
{"Time":"2021-10-04T12:42:53.712594826-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#01","Output":"    --- PASS: TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#01 (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.712599546-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#01","Elapsed":0}
{"Time":"2021-10-04T12:42:53.712603903-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#02","Output":"    --- PASS: TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#02 (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.712608988-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/no_such_file_or_directory[INT-SUM-003]#02","Elapsed":0}
{"Time":"2021-10-04T12:42:53.712613582-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]","Output":"    --- PASS: TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003] (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.712618394-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]","Elapsed":0}
{"Time":"2021-10-04T12:42:53.712622436-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]#01","Output":"    --- PASS: TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]#01 (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.712626153-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors/Must_provide_path_to_.lst[INT-SUM-003]#01","Elapsed":0}
{"Time":"2021-10-04T12:42:53.712629458-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryErrors","Elapsed":0.01}
{"Time":"2021-10-04T12:42:53.712634325-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension"}
{"Time":"2021-10-04T12:42:53.712638863-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension","Output":"=== RUN   TestSummaryHappyPathNoExtension\n"}
{"Time":"2021-10-04T12:42:53.7126815-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension/[INT-SUM-004]"}
{"Time":"2021-10-04T12:42:53.712688811-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension/[INT-SUM-004]","Output":"=== RUN   TestSummaryHappyPathNoExtension/[INT-SUM-004]\n"}
{"Time":"2021-10-04T12:42:53.71582891-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension","Output":"--- PASS: TestSummaryHappyPathNoExtension (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.715845034-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension/[INT-SUM-004]","Output":"    --- PASS: TestSummaryHappyPathNoExtension/[INT-SUM-004] (0.00s)\n"}
{"Time":"2021-10-04T12:42:53.715849793-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension/[INT-SUM-004]","Elapsed":0}
{"Time":"2021-10-04T12:42:53.715854347-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestSummaryHappyPathNoExtension","Elapsed":0}
{"Time":"2021-10-04T12:42:53.715858127-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated"}
{"Time":"2021-10-04T12:42:53.7158619-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated","Output":"=== RUN   TestBBIConfigJSONCreated\n"}
{"Time":"2021-10-04T12:42:53.715868794-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]"}
{"Time":"2021-10-04T12:42:53.715878413-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]","Output":"=== RUN   TestBBIConfigJSONCreated/240[INT-CFG-001]\n"}
{"Time":"2021-10-04T12:42:53.71588368-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]","Output":"    config_test.go:35: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:42:53.730901525-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]/Executable_MTP"}
{"Time":"2021-10-04T12:42:53.730915787-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]/Executable_MTP","Output":"=== RUN   TestBBIConfigJSONCreated/240[INT-CFG-001]/Executable_MTP\n"}
{"Time":"2021-10-04T12:43:00.998091887-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]"}
{"Time":"2021-10-04T12:43:00.998118909-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]","Output":"=== RUN   TestBBIConfigJSONCreated/acop[INT-CFG-001]\n"}
{"Time":"2021-10-04T12:43:00.998129071-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]","Output":"    config_test.go:35: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:01.016541693-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]/acop"}
{"Time":"2021-10-04T12:43:01.016573218-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]/acop","Output":"=== RUN   TestBBIConfigJSONCreated/acop[INT-CFG-001]/acop\n"}
{"Time":"2021-10-04T12:43:08.064686-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]"}
{"Time":"2021-10-04T12:43:08.064724619-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]","Output":"=== RUN   TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]\n"}
{"Time":"2021-10-04T12:43:08.06473333-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]","Output":"    config_test.go:35: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:08.082079536-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]/Executable_MTP"}
{"Time":"2021-10-04T12:43:08.082106881-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]/Executable_MTP","Output":"=== RUN   TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]/Executable_MTP\n"}
{"Time":"2021-10-04T12:43:15.078616872-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/metrum_std[INT-CFG-001]"}
{"Time":"2021-10-04T12:43:15.078651086-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/metrum_std[INT-CFG-001]","Output":"=== RUN   TestBBIConfigJSONCreated/metrum_std[INT-CFG-001]\n"}
{"Time":"2021-10-04T12:43:15.078660296-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/metrum_std[INT-CFG-001]","Output":"    config_test.go:35: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:15.095771666-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated","Output":"--- PASS: TestBBIConfigJSONCreated (21.38s)\n"}
{"Time":"2021-10-04T12:43:15.09579335-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]","Output":"    --- PASS: TestBBIConfigJSONCreated/240[INT-CFG-001] (7.28s)\n"}
{"Time":"2021-10-04T12:43:15.095799493-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]/Executable_MTP","Output":"        --- PASS: TestBBIConfigJSONCreated/240[INT-CFG-001]/Executable_MTP (7.27s)\n"}
{"Time":"2021-10-04T12:43:15.095805518-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]/Executable_MTP","Elapsed":7.27}
{"Time":"2021-10-04T12:43:15.095813368-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/240[INT-CFG-001]","Elapsed":7.28}
{"Time":"2021-10-04T12:43:15.095818088-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]","Output":"    --- PASS: TestBBIConfigJSONCreated/acop[INT-CFG-001] (7.07s)\n"}
{"Time":"2021-10-04T12:43:15.09582627-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]/acop","Output":"        --- PASS: TestBBIConfigJSONCreated/acop[INT-CFG-001]/acop (7.05s)\n"}
{"Time":"2021-10-04T12:43:15.095831958-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]/acop","Elapsed":7.05}
{"Time":"2021-10-04T12:43:15.095841066-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/acop[INT-CFG-001]","Elapsed":7.07}
{"Time":"2021-10-04T12:43:15.095844809-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]","Output":"    --- PASS: TestBBIConfigJSONCreated/ctl_test[INT-CFG-001] (7.01s)\n"}
{"Time":"2021-10-04T12:43:15.095853323-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]/Executable_MTP","Output":"        --- PASS: TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]/Executable_MTP (7.00s)\n"}
{"Time":"2021-10-04T12:43:15.095858023-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]/Executable_MTP","Elapsed":7}
{"Time":"2021-10-04T12:43:15.095861987-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/ctl_test[INT-CFG-001]","Elapsed":7.01}
{"Time":"2021-10-04T12:43:15.09586726-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/metrum_std[INT-CFG-001]","Output":"    --- PASS: TestBBIConfigJSONCreated/metrum_std[INT-CFG-001] (0.02s)\n"}
{"Time":"2021-10-04T12:43:15.095871963-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated/metrum_std[INT-CFG-001]","Elapsed":0.02}
{"Time":"2021-10-04T12:43:15.095876073-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestBBIConfigJSONCreated","Elapsed":21.38}
{"Time":"2021-10-04T12:43:15.095880198-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile"}
{"Time":"2021-10-04T12:43:15.095883768-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile","Output":"=== RUN   TestConfigValuesAreCorrectInWrittenFile\n"}
{"Time":"2021-10-04T12:43:15.095889355-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile","Output":"    config_test.go:99: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:15.110261756-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile/Executable_MTP[INT-CFG-002]"}
{"Time":"2021-10-04T12:43:15.110285938-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile/Executable_MTP[INT-CFG-002]","Output":"=== RUN   TestConfigValuesAreCorrectInWrittenFile/Executable_MTP[INT-CFG-002]\n"}
{"Time":"2021-10-04T12:43:28.45507429-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile","Output":"--- PASS: TestConfigValuesAreCorrectInWrittenFile (13.36s)\n"}
{"Time":"2021-10-04T12:43:28.455120816-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile/Executable_MTP[INT-CFG-002]","Output":"    --- PASS: TestConfigValuesAreCorrectInWrittenFile/Executable_MTP[INT-CFG-002] (13.34s)\n"}
{"Time":"2021-10-04T12:43:28.455129419-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile/Executable_MTP[INT-CFG-002]","Elapsed":13.34}
{"Time":"2021-10-04T12:43:28.455138667-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestConfigValuesAreCorrectInWrittenFile","Elapsed":13.36}
{"Time":"2021-10-04T12:43:28.455143777-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL"}
{"Time":"2021-10-04T12:43:28.455149089-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL","Output":"=== RUN   TestHasValidDataPathForCTL\n"}
{"Time":"2021-10-04T12:43:28.455157093-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL","Output":"    data_test.go:21: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:28.520193647-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL/validPathCTL_Executable_MTP.ctl[INT-DATA-001]"}
{"Time":"2021-10-04T12:43:28.520219681-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL/validPathCTL_Executable_MTP.ctl[INT-DATA-001]","Output":"=== RUN   TestHasValidDataPathForCTL/validPathCTL_Executable_MTP.ctl[INT-DATA-001]\n"}
{"Time":"2021-10-04T12:43:37.203360475-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL","Output":"--- PASS: TestHasValidDataPathForCTL (8.75s)\n"}
{"Time":"2021-10-04T12:43:37.203405107-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL/validPathCTL_Executable_MTP.ctl[INT-DATA-001]","Output":"    --- PASS: TestHasValidDataPathForCTL/validPathCTL_Executable_MTP.ctl[INT-DATA-001] (8.68s)\n"}
{"Time":"2021-10-04T12:43:37.203413083-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL/validPathCTL_Executable_MTP.ctl[INT-DATA-001]","Elapsed":8.68}
{"Time":"2021-10-04T12:43:37.203422488-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidDataPathForCTL","Elapsed":8.75}
{"Time":"2021-10-04T12:43:37.203429006-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath"}
{"Time":"2021-10-04T12:43:37.203433371-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath","Output":"=== RUN   TestHasInvalidDataPath\n"}
{"Time":"2021-10-04T12:43:37.203441689-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath","Output":"    data_test.go:55: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:37.21913751-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]"}
{"Time":"2021-10-04T12:43:37.219159111-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]","Output":"=== RUN   TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]\n"}
{"Time":"2021-10-04T12:43:37.219236636-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl"}
{"Time":"2021-10-04T12:43:37.219251205-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Output":"=== RUN   TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl\n"}
{"Time":"2021-10-04T12:43:37.223145714-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Output":"time=\"2021-10-04T12:43:37-04:00\" level=info msg=\"Command was 'bbi' while arguments were nonmem run local --nm_version nm74gf /data/762/working/ctl_test/Executable_MTP.ctl\"\n"}
{"Time":"2021-10-04T12:43:37.223179314-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Output":"time=\"2021-10-04T12:43:37-04:00\" level=error msg=\"An error occurred trying to execute model. Error details are : exit status 1\"\n"}
{"Time":"2021-10-04T12:43:37.22318801-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Output":"time=\"2021-10-04T12:43:37-04:00\" level=error msg=\"Exit code was 1, details were exit status 1\"\n"}
{"Time":"2021-10-04T12:43:37.223193662-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Output":"time=\"2021-10-04T12:43:37-04:00\" level=error msg=\"output details were: time=\\\"2021-10-04T12:43:37-04:00\\\" level=info msg=\\\"Successfully loaded default configuration from /tmp/drone-2hsYKHYa4hGdkqHw/drone/src/integration/bbi.yaml\\\"\\ntime=\\\"2021-10-04T12:43:37-04:00\\\" level=info msg=\\\"Beginning Local Path\\\"\\ntime=\\\"2021-10-04T12:43:37-04:00\\\" level=fatal msg=\\\"An error occurred during model processing: unable to open datafile at /data/762/working/ctl_test/FData.csv referenced in model file /data/762/working/ctl_test/Executable_MTP.ctl. Error details are open /data/762/working/ctl_test/FData.csv: no such file or directory\\\"\\n\"\n"}
{"Time":"2021-10-04T12:43:37.223210904-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath","Output":"--- PASS: TestHasInvalidDataPath (0.02s)\n"}
{"Time":"2021-10-04T12:43:37.223217084-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]","Output":"    --- PASS: TestHasInvalidDataPath/Executable_MTP[INT-DATA-002] (0.00s)\n"}
{"Time":"2021-10-04T12:43:37.2232232-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Output":"        --- PASS: TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl (0.00s)\n"}
{"Time":"2021-10-04T12:43:37.223228817-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]/invalidPathCTL_Executable_MTP.ctl","Elapsed":0}
{"Time":"2021-10-04T12:43:37.223234834-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath/Executable_MTP[INT-DATA-002]","Elapsed":0}
{"Time":"2021-10-04T12:43:37.223241683-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasInvalidDataPath","Elapsed":0.02}
{"Time":"2021-10-04T12:43:37.22324714-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod"}
{"Time":"2021-10-04T12:43:37.223251357-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod","Output":"=== RUN   TestHasValidComplexPathCTLAndMod\n"}
{"Time":"2021-10-04T12:43:37.223257297-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod","Output":"    data_test.go:112: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:37.235925578-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]"}
{"Time":"2021-10-04T12:43:37.235941383-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"=== RUN   TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]\n"}
{"Time":"2021-10-04T12:43:44.575300442-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:37-04:00\" level=info msg=\"Successfully loaded default configuration from /tmp/drone-2hsYKHYa4hGdkqHw/drone/src/integration/bbi.yaml\"\n"}
{"Time":"2021-10-04T12:43:44.575331101-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:37-04:00\" level=info msg=\"Beginning Local Path\"\n"}
{"Time":"2021-10-04T12:43:44.575338018-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:37-04:00\" level=info msg=\"A total of 1 models have completed the initial preparation phase\"\n"}
{"Time":"2021-10-04T12:43:44.575342785-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:37-04:00\" level=info msg=\"[Executable_MTP] Beginning local work phase\"\n"}
{"Time":"2021-10-04T12:43:44.57534745-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"[Executable_MTP] Beginning cleanup phase\"\n"}
{"Time":"2021-10-04T12:43:44.575354636-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"[Executable_MTP] Cleanup completed\"\n"}
{"Time":"2021-10-04T12:43:44.575360525-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"Waiting for any post execution hooks to finish\"\n"}
{"Time":"2021-10-04T12:43:44.575365787-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"\\r1 models completed in 7.335276946s\"\n"}
{"Time":"2021-10-04T12:43:44.575370101-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"\n"}
{"Time":"2021-10-04T12:43:44.575374065-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"\n"}
{"Time":"2021-10-04T12:43:44.57552201-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]"}
{"Time":"2021-10-04T12:43:44.575533322-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"=== RUN   TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]\n"}
{"Time":"2021-10-04T12:43:51.965799352-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"Successfully loaded default configuration from /tmp/drone-2hsYKHYa4hGdkqHw/drone/src/integration/bbi.yaml\"\n"}
{"Time":"2021-10-04T12:43:51.965833307-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"Beginning Local Path\"\n"}
{"Time":"2021-10-04T12:43:51.9658399-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"A total of 1 models have completed the initial preparation phase\"\n"}
{"Time":"2021-10-04T12:43:51.965845475-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:44-04:00\" level=info msg=\"[Executable_MTP2] Beginning local work phase\"\n"}
{"Time":"2021-10-04T12:43:51.965850383-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:51-04:00\" level=info msg=\"[Executable_MTP2] Beginning cleanup phase\"\n"}
{"Time":"2021-10-04T12:43:51.965855221-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:51-04:00\" level=info msg=\"[Executable_MTP2] Cleanup completed\"\n"}
{"Time":"2021-10-04T12:43:51.965874145-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:51-04:00\" level=info msg=\"Waiting for any post execution hooks to finish\"\n"}
{"Time":"2021-10-04T12:43:51.96588378-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"time=\"2021-10-04T12:43:51-04:00\" level=info msg=\"\\r1 models completed in 7.383415337s\"\n"}
{"Time":"2021-10-04T12:43:51.965888719-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"\n"}
{"Time":"2021-10-04T12:43:51.965893364-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"\n"}
{"Time":"2021-10-04T12:43:51.965902098-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod","Output":"--- PASS: TestHasValidComplexPathCTLAndMod (14.74s)\n"}
{"Time":"2021-10-04T12:43:51.965909314-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Output":"    --- PASS: TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003] (7.34s)\n"}
{"Time":"2021-10-04T12:43:51.965914475-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP.ctl[INT-DATA-003]","Elapsed":7.34}
{"Time":"2021-10-04T12:43:51.965922263-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Output":"    --- PASS: TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003] (7.39s)\n"}
{"Time":"2021-10-04T12:43:51.965927705-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod/validComplexPathFor_Executable_MTP2.mod[INT-DATA-003]","Elapsed":7.39}
{"Time":"2021-10-04T12:43:51.965932014-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHasValidComplexPathCTLAndMod","Elapsed":14.74}
{"Time":"2021-10-04T12:43:51.965936532-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization"}
{"Time":"2021-10-04T12:43:51.965940883-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization","Output":"=== RUN   TestInitialization\n"}
{"Time":"2021-10-04T12:43:51.965946278-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]"}
{"Time":"2021-10-04T12:43:51.965950924-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]","Output":"=== RUN   TestInitialization/acop[INT-INIT-001]\n"}
{"Time":"2021-10-04T12:43:51.965955656-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]","Output":"    init_test.go:31: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:51.98130356-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]/init_acop"}
{"Time":"2021-10-04T12:43:51.981322802-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]/init_acop","Output":"=== RUN   TestInitialization/acop[INT-INIT-001]/init_acop\n"}
{"Time":"2021-10-04T12:43:51.98862189-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization","Output":"--- PASS: TestInitialization (0.02s)\n"}
{"Time":"2021-10-04T12:43:51.98864063-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]","Output":"    --- PASS: TestInitialization/acop[INT-INIT-001] (0.02s)\n"}
{"Time":"2021-10-04T12:43:51.988646558-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]/init_acop","Output":"        --- PASS: TestInitialization/acop[INT-INIT-001]/init_acop (0.01s)\n"}
{"Time":"2021-10-04T12:43:51.988668907-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]/init_acop","Elapsed":0.01}
{"Time":"2021-10-04T12:43:51.988676644-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization/acop[INT-INIT-001]","Elapsed":0.02}
{"Time":"2021-10-04T12:43:51.988681047-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestInitialization","Elapsed":0.02}
{"Time":"2021-10-04T12:43:51.988685373-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds"}
{"Time":"2021-10-04T12:43:51.988690482-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds","Output":"=== RUN   TestNMQUALExecutionSucceeds\n"}
{"Time":"2021-10-04T12:43:51.988695163-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds","Output":"    nmqual_test.go:22: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:43:52.004371531-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds/Executable_MTP[INT-NMQ-001]"}
{"Time":"2021-10-04T12:43:52.004389949-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds/Executable_MTP[INT-NMQ-001]","Output":"=== RUN   TestNMQUALExecutionSucceeds/Executable_MTP[INT-NMQ-001]\n"}
{"Time":"2021-10-04T12:44:04.6595256-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds","Output":"--- PASS: TestNMQUALExecutionSucceeds (12.67s)\n"}
{"Time":"2021-10-04T12:44:04.659560176-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds/Executable_MTP[INT-NMQ-001]","Output":"    --- PASS: TestNMQUALExecutionSucceeds/Executable_MTP[INT-NMQ-001] (12.66s)\n"}
{"Time":"2021-10-04T12:44:04.659569479-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds/Executable_MTP[INT-NMQ-001]","Elapsed":12.66}
{"Time":"2021-10-04T12:44:04.659577397-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestNMQUALExecutionSucceeds","Elapsed":12.67}
{"Time":"2021-10-04T12:44:04.659581645-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile"}
{"Time":"2021-10-04T12:44:04.659585981-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile","Output":"=== RUN   TestHashingForNMQualWorksWithOriginalModFile\n"}
{"Time":"2021-10-04T12:44:04.659591228-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile","Output":"    nmqual_test.go:66: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:44:04.725638062-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile/Executable_MTP[INT-NMQ-002]"}
{"Time":"2021-10-04T12:44:04.725672461-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile/Executable_MTP[INT-NMQ-002]","Output":"=== RUN   TestHashingForNMQualWorksWithOriginalModFile/Executable_MTP[INT-NMQ-002]\n"}
{"Time":"2021-10-04T12:44:19.290323028-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile","Output":"--- PASS: TestHashingForNMQualWorksWithOriginalModFile (14.63s)\n"}
{"Time":"2021-10-04T12:44:19.290356576-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile/Executable_MTP[INT-NMQ-002]","Output":"    --- PASS: TestHashingForNMQualWorksWithOriginalModFile/Executable_MTP[INT-NMQ-002] (14.56s)\n"}
{"Time":"2021-10-04T12:44:19.2903638-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile/Executable_MTP[INT-NMQ-002]","Elapsed":14.56}
{"Time":"2021-10-04T12:44:19.290380292-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestHashingForNMQualWorksWithOriginalModFile","Elapsed":14.63}
{"Time":"2021-10-04T12:44:19.29038519-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion"}
{"Time":"2021-10-04T12:44:19.290390079-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion","Output":"=== RUN   TestKVPExpansion\n"}
{"Time":"2021-10-04T12:44:19.290397415-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion/[INT-POSTEX-001]"}
{"Time":"2021-10-04T12:44:19.290402007-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion/[INT-POSTEX-001]","Output":"=== RUN   TestKVPExpansion/[INT-POSTEX-001]\n"}
{"Time":"2021-10-04T12:44:19.290488358-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion","Output":"--- PASS: TestKVPExpansion (0.00s)\n"}
{"Time":"2021-10-04T12:44:19.290511972-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion/[INT-POSTEX-001]","Output":"    --- PASS: TestKVPExpansion/[INT-POSTEX-001] (0.00s)\n"}
{"Time":"2021-10-04T12:44:19.290522564-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion/[INT-POSTEX-001]","Elapsed":0}
{"Time":"2021-10-04T12:44:19.290527952-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestKVPExpansion","Elapsed":0}
{"Time":"2021-10-04T12:44:19.290531588-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds"}
{"Time":"2021-10-04T12:44:19.290535448-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds","Output":"=== RUN   TestPostExecutionSucceeds\n"}
{"Time":"2021-10-04T12:44:19.290539586-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/[INT-POSTEX-002]"}
{"Time":"2021-10-04T12:44:19.290543382-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/[INT-POSTEX-002]","Output":"=== RUN   TestPostExecutionSucceeds/[INT-POSTEX-002]\n"}
{"Time":"2021-10-04T12:44:19.290549444-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/[INT-POSTEX-002]","Output":"    postexecution_test.go:85: Beginning work with /data/762/working as the root\n"}
{"Time":"2021-10-04T12:44:19.294938619-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]"}
{"Time":"2021-10-04T12:44:19.29495829-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]","Output":"=== RUN   TestPostExecutionSucceeds/acop[INT-POSTEX-002]\n"}
{"Time":"2021-10-04T12:44:19.350210807-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]/acop_post_execution"}
{"Time":"2021-10-04T12:44:19.350228583-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]/acop_post_execution","Output":"=== RUN   TestPostExecutionSucceeds/acop[INT-POSTEX-002]/acop_post_execution\n"}
{"Time":"2021-10-04T12:44:28.061416368-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]"}
{"Time":"2021-10-04T12:44:28.061450478-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]","Output":"=== RUN   TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]\n"}
{"Time":"2021-10-04T12:44:28.073613256-04:00","Action":"run","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]"}
{"Time":"2021-10-04T12:44:28.073636289-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Output":"=== RUN   TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]\n"}
{"Time":"2021-10-04T12:44:28.085324672-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Output":"time=\"2021-10-04T12:44:28-04:00\" level=info msg=\"Command was 'bbi' while arguments were nonmem --nm_version nm74gf run local --post_work_executable /data/762/post.sh --overwrite=false /data/762/working/acop/acop.mod\"\n"}
{"Time":"2021-10-04T12:44:28.08534936-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Output":"time=\"2021-10-04T12:44:28-04:00\" level=error msg=\"An error occurred trying to execute model. Error details are : exit status 1\"\n"}
{"Time":"2021-10-04T12:44:28.085358503-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Output":"time=\"2021-10-04T12:44:28-04:00\" level=error msg=\"Exit code was 1, details were exit status 1\"\n"}
{"Time":"2021-10-04T12:44:28.085363699-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Output":"time=\"2021-10-04T12:44:28-04:00\" level=error msg=\"output details were: time=\\\"2021-10-04T12:44:28-04:00\\\" level=info msg=\\\"Successfully loaded default configuration from /tmp/drone-2hsYKHYa4hGdkqHw/drone/src/integration/bbi.yaml\\\"\\ntime=\\\"2021-10-04T12:44:28-04:00\\\" level=info msg=\\\"Beginning Local Path\\\"\\ntime=\\\"2021-10-04T12:44:28-04:00\\\" level=info msg=\\\"A total of 1 models have completed the initial preparation phase\\\"\\ntime=\\\"2021-10-04T12:44:28-04:00\\\" level=info msg=\\\"Waiting for any post execution hooks to finish\\\"\\ntime=\\\"2021-10-04T12:44:28-04:00\\\" level=error msg=\\\"1 errors were experienced during the run\\\"\\ntime=\\\"2021-10-04T12:44:28-04:00\\\" level=error msg=\\\"Errors were experienced while running model acop. Details are The target directory, /data/762/working/acop/acop already exist, but we are configured not to overwrite. Invalid configuration / run state\\\"\\ntime=\\\"2021-10-04T12:44:28-04:00\\\" level=info msg=\\\"\\\\r1 models completed in 7.843019ms\\\"\\n\\n\"\n"}
{"Time":"2021-10-04T12:44:28.085466598-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds","Output":"--- PASS: TestPostExecutionSucceeds (8.79s)\n"}
{"Time":"2021-10-04T12:44:28.085483111-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/[INT-POSTEX-002]","Output":"    --- PASS: TestPostExecutionSucceeds/[INT-POSTEX-002] (0.00s)\n"}
{"Time":"2021-10-04T12:44:28.085488644-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/[INT-POSTEX-002]","Elapsed":0}
{"Time":"2021-10-04T12:44:28.085507565-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]","Output":"    --- PASS: TestPostExecutionSucceeds/acop[INT-POSTEX-002] (8.77s)\n"}
{"Time":"2021-10-04T12:44:28.085513502-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]/acop_post_execution","Output":"        --- PASS: TestPostExecutionSucceeds/acop[INT-POSTEX-002]/acop_post_execution (8.71s)\n"}
{"Time":"2021-10-04T12:44:28.085518541-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]/acop_post_execution","Elapsed":8.71}
{"Time":"2021-10-04T12:44:28.085523264-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/acop[INT-POSTEX-002]","Elapsed":8.77}
{"Time":"2021-10-04T12:44:28.085527651-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]","Output":"    --- PASS: TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002] (0.02s)\n"}
{"Time":"2021-10-04T12:44:28.085533014-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Output":"        --- PASS: TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002] (0.01s)\n"}
{"Time":"2021-10-04T12:44:28.085539154-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]/acop[INT-POSTEX-002]","Elapsed":0.01}
{"Time":"2021-10-04T12:44:28.085543172-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds/verify_failure_results[INT-POSTEX-002]","Elapsed":0.02}
{"Time":"2021-10-04T12:44:28.085547291-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Test":"TestPostExecutionSucceeds","Elapsed":8.79}
{"Time":"2021-10-04T12:44:28.08555167-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Output":"PASS\n"}
{"Time":"2021-10-04T12:44:28.086651225-04:00","Action":"output","Package":"github.com/metrumresearchgroup/bbi/integration","Output":"ok  \tgithub.com/metrumresearchgroup/bbi/integration\t421.629s\n"}
{"Time":"2021-10-04T12:44:28.112479572-04:00","Action":"pass","Package":"github.com/metrumresearchgroup/bbi/integration","Elapsed":421.655}
seth127 commented 3 years ago

pkgr output from @Dreznel

Screen Shot 2021-10-05 at 2 49 12 PM

(this is from the pkgr-3.0-rc2-output.json you sent me, but github won't let me post it)

seth127 commented 3 years ago

Going ahead with this now because it's working for the bbi output. @Dreznel @shairozan if we need to make changes later for pkgr, etc. we can tweak this in a future release.