Views Reply Votes
Lenard McMinn
Lenard
 0
Can/How does the YAB tool support custom database schema changes?
128
9
00
Posted: Feb 12, 2020   
Votes
Will Buttitta
Will
 20
Replied 

The answer to (1) is that YAB can manage schema for any Progress database and the answer to (2) is that if the schema for a given database is completely managed by YAB you can and should have "allowunrecognizedschema" set to false. Enabling "allowunrecognizedschema" adds complexity to schema management that is best to avoid when you can.

Let me describe at a high level how YAB processes schema. Ultimately the goal is to create a temporary reference database (named configured) that has the schema that is currently configured and then delegate to Progress to compare this reference database with the actual database to produce an incremental schema file that describes how to update the actual database schema to match the configured database schema

The error you see occurs when we attempt to create the configured database because we are loading schema that references the table "xart_det" but we don't have the schema for "xart_det".

You can correct this problem by dumping the custom database schema using the YAB "schema-dump" command or the Progress data dictionary and putting this into your customization directory:

<QADHOME>/customizations/schema/custom

The simplest model and the one we recommend is that you would have a single DF file that represents the schema you desire but if there is a compelling reason to distribute the schema across multiple files you can put all the files in that directory and we will automatically figure out the dependency order in which they should be loaded from YAB 1.6 on (in other words this setting "schema.customization-custom.direct=true" is ignored from 1.6 on).

00
Replied: Feb 12, 2020
Votes
Lenard McMinn
Lenard
 0
Replied 

That did seem to do the trick - adding a custom.df dump to ...schema/custom.  However, YAB did not seem to pick up my incremental that was also in the same directory - CR1234-trigger-remove.df

Is there a naming convention for the second "incremental" file?  Do I leave these df files in the directory going forward? (Seems like I should)

00
Replied: Feb 14, 2020
Votes
Will Buttitta
Will
 20
Replied 

I did not notice that you had configured the "dir" AND "file" setting on your schema configuration. You should remove the "file" setting which is causing the "dir" setting to be ignored (it is one or the other). With the directory configured alone, it will process any files in that directory that end in ".df" as schema files.

Remove this:
schema.customization-custom.file=<QADHOME>/customizations/schema/custom/custom.df

And yes you should leave the schema files in the directory even after they have successfully loaded into the custom database. A general principle in YAB, which applies here as well, is that the configuration (and files referenced from the configuration) should describe the system you want. Commands like "yab update" ensure the system matches this configuration.
 

00
Replied: Feb 14, 2020
Votes
Lenard McMinn
Lenard
 0
Replied 

Pulling out the file= seemed to solve that issue.  YAB appears to process the custom.df just fine.
However, when YAB moves on to the next file in the directory, it again seems to try and apply the changes
to the primary and not the custom database.  While that is an educated guess at best, all the objects
are indeed unknown:

The following errors and/or warnings occurred while loading
QADHOME>/customizations/schema/custom/CR8735-1-Triggers.df
into database configured on 02/18/20 at 07:19.
** Error during MODIFY TABLE xart_det **
** Line 1 UPDATE TABLE xart_det
Try to modify unknown TABLE
** Error during DELETE ? ? **
** Line 2 DELETE
Unknown object
** Error during DELETE ? ? **
** Line 3 DELETE
Unknown object
** Error during MODIFY TABLE xfcstd_det **
** Line 5 UPDATE TABLE xfcstd_det
Try to modify unknown TABLE
** Error during DELETE ? ? **
** Line 6 DELETE
Unknown object
** Error during MODIFY TABLE xpt_mstr **
** Line 8 UPDATE TABLE xpt_mstr
Try to modify unknown TABLE
** Error during DELETE ? ? **
** Line 9 DELETE
Unknown object
** Error during MODIFY TABLE xtod_det **
** Line 11 UPDATE TABLE xtod_det
Try to modify unknown TABLE
** Error during DELETE ? ? **
** Line 12 DELETE
Unknown object
** Error during MODIFY TABLE xvd_mstr **
** Line 14 UPDATE TABLE xvd_mstr
Try to modify unknown TABLE
02/18/20 07:19 : Load of
<QADHOME>/customizations/schema/custom/CR8735-1-Triggers.df into database configured was unsuccessful.
 All the changes were backed out...

 

00
Replied: Feb 18, 2020
Votes
Will Buttitta
Will
 20
Replied 

The failure is not occuring loading schema into the primary or custom database but the temporary database we use to determine the difference between what is configured and what is installed. This database is called "configured".

What schema file defines the table "xart_det"? Is it the "custom.df" file? If so do you see that DF file being loaded into the configured database before the CR8735-1-Triggers.df file? 

00
Replied: Feb 18, 2020
Votes
Lenard McMinn
Lenard
 0
Replied 

Yes.  custom.df is the current state of the custom database - and that includes the xart_det.

As for seeing the custom.df being loaded, no.  I don't think I do see that in the log file.  I see the extents being built off the structure file, but out of 1250 lines in the log file, I do not see where it would be loaded from the structure file.

2020-02-18 07:17:39,060 INFO  [main] Main - ======================== START ========================
2020-02-18 07:17:39,067 DEBUG [main] Main - Args: [yab update -a:/app/qad/uat].
2020-02-18 07:17:39,067 DEBUG [main] Main - Application: [/app/qad/uat].
2020-02-18 07:17:39,067 DEBUG [main] Main - User: [mfg].
2020-02-18 07:17:39,072 DEBUG [main] Main - Host: [thor.exac.com].
2020-02-18 07:17:39,072 DEBUG [main] Main - Client: [/app/qad/uat/build/client].
2020-02-18 07:17:39,073 DEBUG [main] Main - Java: [/app/java/jdk1.8.0_191/jre (1.8.0_191)].
2020-02-18 07:17:39,129 DEBUG [main] BuildFactory - Using archived configuration data.
2020-02-18 07:17:40,194 DEBUG [main] Main - Reloading context.
2020-02-18 07:17:40,222 DEBUG [main] BuildFactory - Using refreshed configuration data.
2020-02-18 07:17:40,270 DEBUG [main] BuildFactory - Skipped check for software updates.
2020-02-18 07:17:40,825 DEBUG [main] BuildContext - system-config-init
2020-02-18 07:17:40,826 DEBUG [main] BuildContext - system-config-init OK
2020-02-18 07:17:40,827 DEBUG [main] BuildContext - system-config-package-init
2020-02-18 07:17:41,089 DEBUG [main] BuildContext - system-config-package-init OK
2020-02-18 07:17:41,090 DEBUG [main] BuildContext - system-config-before-configure
2020-02-18 07:17:41,096 DEBUG [main] BuildContext - system-config-before-configure OK
2020-02-18 07:17:41,096 DEBUG [main] BuildContext - system-config-pre-refresh
2020-02-18 07:17:41,096 DEBUG [main] BuildContext - system-config-pre-refresh OK
2020-02-18 07:17:41,103 DEBUG [main] BuildContext - extension-scan
2020-02-18 07:17:41,104 DEBUG [main] BuildContext - extension-scan OK
2020-02-18 07:17:41,104 DEBUG [main] BuildContext - system-config-extension-init
2020-02-18 07:17:41,123 DEBUG [main] BuildContext - system-config-extension-init OK
2020-02-18 07:17:41,123 DEBUG [main] BuildContext - content-scan
2020-02-18 07:17:42,582 DEBUG [main] BuildContext - content-scan OK
2020-02-18 07:17:42,582 DEBUG [main] BuildContext - content-configure
2020-02-18 07:17:42,651 DEBUG [main] BuildContext - content-configure OK
2020-02-18 07:17:42,651 DEBUG [main] BuildContext - system-config-configure
2020-02-18 07:17:42,911 DEBUG [main] BuildContext - system-config-configure OK
2020-02-18 07:17:42,911 DEBUG [main] BuildContext - system-config-final-configure
2020-02-18 07:17:43,012 DEBUG [main] BuildContext - system-config-final-configure OK
2020-02-18 07:17:43,012 DEBUG [main] BuildContext - system-config-validate
2020-02-18 07:17:43,115 DEBUG [main] BuildContext - system-config-validate OK
2020-02-18 07:17:43,115 DEBUG [main] BuildContext - system-config-after-configure
2020-02-18 07:17:43,298 DEBUG [main] BuildContext - system-config-after-configure OK
2020-02-18 07:17:43,298 DEBUG [main] BuildContext - system-config-final-after-configure
2020-02-18 07:17:43,299 DEBUG [main] BuildContext - system-config-final-after-configure OK
2020-02-18 07:17:43,299 DEBUG [main] BuildContext - content-order
2020-02-18 07:17:43,299 DEBUG [main] BuildContext - content-order OK
2020-02-18 07:17:43,299 DEBUG [main] BuildContext - system-config-save
2020-02-18 07:17:43,362 DEBUG [main] BuildContext - system-config-save OK
2020-02-18 07:17:43,362 DEBUG [main] BuildContext - system-config-refresh
2020-02-18 07:17:43,362 DEBUG [main] BuildContext - system-config-refresh OK
2020-02-18 07:17:43,402 DEBUG [main] BuildContext - openedge-upgrade-check
2020-02-18 07:17:43,411 DEBUG [main] BuildContext - openedge-upgrade-check SKIPPED
2020-02-18 07:17:43,411 DEBUG [main] BuildContext - alerts-stage
2020-02-18 07:17:43,428 DEBUG [main] AlertsStageProcess - [alerts-bundled-1.3.2.6] is already staged in [/app/qad/uat/build/work/system/processes/alerts-stage].
2020-02-18 07:17:43,428 DEBUG [main] BuildContext - alerts-stage OK
2020-02-18 07:17:43,428 DEBUG [main] BuildContext - copy-alerts-bundled-patch-webapp-update
2020-02-18 07:17:43,435 DEBUG [main] BuildContext - copy-alerts-bundled-patch-webapp-update OK
2020-02-18 07:17:43,435 DEBUG [main] BuildContext - elastic-update
2020-02-18 07:17:43,435 DEBUG [main] BuildContext - elastic-update OK
2020-02-18 07:17:43,435 DEBUG [main] BuildContext - trans-dotdees-fhd-stage
2020-02-18 07:17:43,442 DEBUG [main] TransDotDeesFhdStage - [trans-dotdees-fhd-9.3.18.1] is already staged in [/app/qad/uat/build/work/trans-dotdees-fhd/cs].
2020-02-18 07:17:43,448 DEBUG [main] TransDotDeesFhdStage - [trans-dotdees-fhd-9.3.18.1] is already staged in [/app/qad/uat/build/work/trans-dotdees-fhd/fr].
2020-02-18 07:17:43,449 DEBUG [main] TransDotDeesFhdStage - [trans-dotdees-fhd-9.3.18.1] is already staged in [/app/qad/uat/build/work/trans-dotdees-fhd/ge].
2020-02-18 07:17:43,450 DEBUG [main] TransDotDeesFhdStage - [trans-dotdees-fhd-9.3.18.1] is already staged in [/app/qad/uat/build/work/trans-dotdees-fhd/jp].
2020-02-18 07:17:43,450 DEBUG [main] BuildContext - trans-dotdees-fhd-stage OK
2020-02-18 07:17:43,450 DEBUG [main] BuildContext - qxtend-stage
2020-02-18 07:17:43,458 DEBUG [main] BuildContext - qxtend-stage SKIPPED
2020-02-18 07:17:43,458 DEBUG [main] BuildContext - stage
2020-02-18 07:17:43,459 DEBUG [main] BuildContext - stage OK
2020-02-18 07:17:43,459 DEBUG [main] BuildContext - script-backup
2020-02-18 07:17:43,459 DEBUG [main] BuildContext - script-backup SKIPPED
2020-02-18 07:17:43,459 DEBUG [main] BuildContext - qxtend-client-update
2020-02-18 07:17:43,559 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-qxtend] from the template [/app/qad/uat/build/catalog/packages/yab-qxtend/1/6/6/3/etc/client-qxtend-template.py].
2020-02-18 07:17:43,560 DEBUG [main] BuildContext - qxtend-client-update OK
2020-02-18 07:17:43,560 DEBUG [main] BuildContext - qxtend-qgen-update
2020-02-18 07:17:43,583 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-qgen] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:43,584 DEBUG [main] BuildContext - qxtend-qgen-update OK
2020-02-18 07:17:43,584 DEBUG [main] BuildContext - adminserver-update
2020-02-18 07:17:43,587 DEBUG [main] BuildContext - adminserver-update OK
2020-02-18 07:17:43,587 DEBUG [main] BuildContext - adminserver-plugins-configure
2020-02-18 07:17:43,591 DEBUG [main] BuildContext - adminserver-plugins-configure SKIPPED
2020-02-18 07:17:43,591 DEBUG [main] BuildContext - adminserver-script
2020-02-18 07:17:43,601 DEBUG [main] BuildContext - adminserver-script OK
2020-02-18 07:17:43,601 DEBUG [main] BuildContext - nameserver-script
2020-02-18 07:17:43,613 DEBUG [main] BuildContext - nameserver-script OK
2020-02-18 07:17:43,613 DEBUG [main] BuildContext - database-script
2020-02-18 07:17:43,667 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,689 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,690 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,690 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,691 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:43,721 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,737 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,738 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,738 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,738 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:43,739 DEBUG [main] BuildContext - database-script OK
2020-02-18 07:17:43,739 DEBUG [main] BuildContext - appserver-script
2020-02-18 07:17:43,768 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,783 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,785 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,785 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,785 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:43,800 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-fin-stop] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/appserver-stop.py].
2020-02-18 07:17:43,803 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-mfg-stop] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/appserver-stop.py].
2020-02-18 07:17:43,805 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-qra-stop] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/appserver-stop.py].
2020-02-18 07:17:43,808 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-qxosi-stop] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/appserver-stop.py].
2020-02-18 07:17:43,810 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-qxoui-stop] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/appserver-stop.py].
2020-02-18 07:17:43,812 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-qxtnative-stop] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/appserver-stop.py].
2020-02-18 07:17:43,812 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,827 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,828 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,828 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,828 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:43,829 DEBUG [main] BuildContext - appserver-script OK
2020-02-18 07:17:43,829 DEBUG [main] BuildContext - webspeed-script
2020-02-18 07:17:43,921 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,936 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,937 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,937 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,938 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:43,942 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,957 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,958 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,958 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,958 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:43,958 DEBUG [main] BuildContext - webspeed-script OK
2020-02-18 07:17:43,958 DEBUG [main] BuildContext - tomcat-script
2020-02-18 07:17:43,970 INFO  [main] TomcatControlCommand - Starting [/app/qad/uat/servers/tomcat].
2020-02-18 07:17:43,974 INFO  [main] TomcatControlCommand - Starting [/app/qad/uat/servers/tomcat-qxtend].
2020-02-18 07:17:43,974 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:43,997 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:43,998 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:43,998 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:43,998 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:44,003 INFO  [main] TomcatControlCommand - Stopping [/app/qad/uat/servers/tomcat].
2020-02-18 07:17:44,005 INFO  [main] TomcatControlCommand - Stopping [/app/qad/uat/servers/tomcat-qxtend].
2020-02-18 07:17:44,006 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:44,024 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:44,025 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:44,025 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:44,025 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:44,026 DEBUG [main] BuildContext - tomcat-script OK
2020-02-18 07:17:44,026 DEBUG [main] BuildContext - batch-script
2020-02-18 07:17:44,027 DEBUG [main] BuildContext - batch-script OK
2020-02-18 07:17:44,027 DEBUG [main] BuildContext - foundation-pset-update
2020-02-18 07:17:44,042 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/pset] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/pset].
2020-02-18 07:17:44,042 DEBUG [main] BuildContext - foundation-pset-update OK
2020-02-18 07:17:44,042 DEBUG [main] BuildContext - foundation-batchclient-update
2020-02-18 07:17:44,053 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/batch.py] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,053 DEBUG [main] BuildContext - foundation-batchclient-update OK
2020-02-18 07:17:44,053 DEBUG [main] BuildContext - foundation-chui-client-xx-update
2020-02-18 07:17:44,061 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-xx] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/client-xx-template.py].
2020-02-18 07:17:44,064 DEBUG [main] BuildContext - foundation-chui-client-xx-update OK
2020-02-18 07:17:44,064 DEBUG [main] BuildContext - elastic-script
2020-02-18 07:17:44,065 DEBUG [main] BuildContext - elastic-script OK
2020-02-18 07:17:44,065 DEBUG [main] BuildContext - fin-sync-update
2020-02-18 07:17:44,074 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/finsync] from the template [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc/finsync.py].
2020-02-18 07:17:44,075 DEBUG [main] BuildContext - fin-sync-update OK
2020-02-18 07:17:44,075 DEBUG [main] BuildContext - daemon-script
2020-02-18 07:17:44,100 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:44,115 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:44,116 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:44,116 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:44,116 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:44,116 DEBUG [main] BuildContext - daemon-script OK
2020-02-18 07:17:44,116 DEBUG [main] BuildContext - chui-client-ini-update
2020-02-18 07:17:44,116 DEBUG [main] BuildContext - chui-client-ini-update OK
2020-02-18 07:17:44,116 DEBUG [main] BuildContext - chui-client-us-update
2020-02-18 07:17:44,123 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-us] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,124 DEBUG [main] BuildContext - chui-client-us-update OK
2020-02-18 07:17:44,124 DEBUG [main] BuildContext - aim-client-us-update
2020-02-18 07:17:44,129 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-aim-us] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,129 DEBUG [main] BuildContext - aim-client-us-update OK
2020-02-18 07:17:44,130 DEBUG [main] BuildContext - chui-client-cs-update
2020-02-18 07:17:44,140 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-cs] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,140 DEBUG [main] BuildContext - chui-client-cs-update OK
2020-02-18 07:17:44,140 DEBUG [main] BuildContext - aim-client-cs-update
2020-02-18 07:17:44,146 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-aim-cs] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,146 DEBUG [main] BuildContext - aim-client-cs-update OK
2020-02-18 07:17:44,146 DEBUG [main] BuildContext - chui-client-fr-update
2020-02-18 07:17:44,152 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-fr] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,152 DEBUG [main] BuildContext - chui-client-fr-update OK
2020-02-18 07:17:44,152 DEBUG [main] BuildContext - aim-client-fr-update
2020-02-18 07:17:44,158 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-aim-fr] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,158 DEBUG [main] BuildContext - aim-client-fr-update OK
2020-02-18 07:17:44,158 DEBUG [main] BuildContext - chui-client-ge-update
2020-02-18 07:17:44,164 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-ge] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,164 DEBUG [main] BuildContext - chui-client-ge-update OK
2020-02-18 07:17:44,164 DEBUG [main] BuildContext - aim-client-ge-update
2020-02-18 07:17:44,169 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-aim-ge] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,169 DEBUG [main] BuildContext - aim-client-ge-update OK
2020-02-18 07:17:44,169 DEBUG [main] BuildContext - chui-client-jp-update
2020-02-18 07:17:44,180 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-jp] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,180 DEBUG [main] BuildContext - chui-client-jp-update OK
2020-02-18 07:17:44,180 DEBUG [main] BuildContext - aim-client-jp-update
2020-02-18 07:17:44,188 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/client-aim-jp] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,188 DEBUG [main] BuildContext - aim-client-jp-update OK
2020-02-18 07:17:44,188 DEBUG [main] BuildContext - netui-telnet-update
2020-02-18 07:17:44,195 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/telnet] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,195 DEBUG [main] BuildContext - netui-telnet-update OK
2020-02-18 07:17:44,195 DEBUG [main] BuildContext - netui-connmgr-update
2020-02-18 07:17:44,202 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/connmgr] from the template [/app/qad/uat/localYab/templates/client-template.py].
2020-02-18 07:17:44,202 DEBUG [main] BuildContext - netui-connmgr-update OK
2020-02-18 07:17:44,202 DEBUG [main] BuildContext - qxo-services-script
2020-02-18 07:17:44,204 DEBUG [main] BuildContext - qxo-services-script OK
2020-02-18 07:17:44,204 DEBUG [main] BuildContext - script-update
2020-02-18 07:17:44,204 DEBUG [main] BuildContext - script-update OK
2020-02-18 07:17:44,204 DEBUG [main] BuildContext - batchclient-update
2020-02-18 07:17:44,450 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/batch.sh] from the template [/app/qad/uat/localYab/templates/batch-template.sh].
2020-02-18 07:17:44,450 DEBUG [main] BuildContext - batchclient-update OK
2020-02-18 07:17:44,450 DEBUG [main] BuildContext - editor-compile-script-update
2020-02-18 07:17:44,465 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/compile.sh] from the template [/app/qad/uat/localYab/templates/compile-template.sh].
2020-02-18 07:17:44,465 DEBUG [main] BuildContext - editor-compile-script-update OK
2020-02-18 07:17:44,465 DEBUG [main] BuildContext - edixsnf-update
2020-02-18 07:17:44,480 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/edixsnf.sh] from the template [/app/qad/uat/localYab/templates/edixsnf-template.sh].
2020-02-18 07:17:44,480 DEBUG [main] BuildContext - edixsnf-update OK
2020-02-18 07:17:44,480 DEBUG [main] BuildContext - db-backup-update
2020-02-18 07:17:44,516 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/backup.sh] from the template [/app/qad/uat/localYab/templates/backup-db-template.sh].
2020-02-18 07:17:44,516 DEBUG [main] BuildContext - db-backup-update OK
2020-02-18 07:17:44,516 DEBUG [main] BuildContext - custom-compile-update
2020-02-18 07:17:44,528 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/compile-custom.sh] from the template [/app/qad/uat/localYab/templates/compile-cust-template.sh].
2020-02-18 07:17:44,528 DEBUG [main] BuildContext - custom-compile-update OK
2020-02-18 07:17:44,528 DEBUG [main] BuildContext - ws-cgiip-update
2020-02-18 07:17:44,536 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/uat.prop] from the template [/app/qad/uat/localYab/templates/cgiip-template.sh].
2020-02-18 07:17:44,536 DEBUG [main] BuildContext - ws-cgiip-update OK
2020-02-18 07:17:44,537 DEBUG [main] BuildContext - get-email-update
2020-02-18 07:17:44,547 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/get_qad_email.sh] from the template [/app/qad/uat/localYab/templates/get-email-template.sh].
2020-02-18 07:17:44,548 DEBUG [main] BuildContext - get-email-update OK
2020-02-18 07:17:44,548 DEBUG [main] BuildContext - get-userid-update
2020-02-18 07:17:44,557 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/get_qad_userid.sh] from the template [/app/qad/uat/localYab/templates/get-user-template.sh].
2020-02-18 07:17:44,558 DEBUG [main] BuildContext - get-userid-update OK
2020-02-18 07:17:44,558 DEBUG [main] BuildContext - daemon-check-update
2020-02-18 07:17:44,567 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/daemon-check.sh] from the template [/app/qad/uat/localYab/templates/daemon-check-template.sh].
2020-02-18 07:17:44,567 DEBUG [main] BuildContext - daemon-check-update OK
2020-02-18 07:17:44,567 DEBUG [main] BuildContext - appserver-check-update
2020-02-18 07:17:44,582 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/scripts/appserver-check.sh] from the template [/app/qad/uat/localYab/templates/appserver-check-template.sh].
2020-02-18 07:17:44,583 DEBUG [main] BuildContext - appserver-check-update OK
2020-02-18 07:17:44,583 DEBUG [main] BuildContext - qrfemail-update
2020-02-18 07:17:44,599 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/config/qrf-email.config] from the template [/app/qad/uat/localYab/templates/qrf-email.txt].
2020-02-18 07:17:44,599 DEBUG [main] BuildContext - qrfemail-update OK
2020-02-18 07:17:44,599 DEBUG [main] BuildContext - qxidata-update
2020-02-18 07:17:44,619 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/config/qxi-data.config] from the template [/app/qad/uat/localYab/templates/qxidata-template.txt].
2020-02-18 07:17:44,619 DEBUG [main] BuildContext - qxidata-update OK
2020-02-18 07:17:44,620 DEBUG [main] BuildContext - eoblink-update
2020-02-18 07:17:44,639 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/config/eob-link.config] from the template [/app/qad/uat/localYab/templates/eob-link.txt].
2020-02-18 07:17:44,639 DEBUG [main] BuildContext - eoblink-update OK
2020-02-18 07:17:44,639 DEBUG [main] BuildContext - logrotate
2020-02-18 07:17:44,639 DEBUG [main] BuildContext - logrotate OK
2020-02-18 07:17:44,639 DEBUG [main] BuildContext - script-master-update
2020-02-18 07:17:44,641 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:44,656 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:44,657 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:44,657 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:44,657 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:44,659 DEBUG [main] PythonVersionCommand - /bin/python -c "import sys; print(sys.hexversion)"
2020-02-18 07:17:44,673 DEBUG [Thread-4] STDOUT - 34014704
2020-02-18 07:17:44,674 DEBUG [main] PythonVersionCommand - Python hexversion output: [34014704]
2020-02-18 07:17:44,674 DEBUG [main] PythonVersionCommand - hexversion hex value: [0x20705f0]
2020-02-18 07:17:44,674 DEBUG [main] PythonVersionCommand - Intepreted python version: [2.7.5.240]
2020-02-18 07:17:44,675 DEBUG [main] BuildContext - script-master-update OK
2020-02-18 07:17:44,675 DEBUG [main] BuildContext - path-alerts-config-update
2020-02-18 07:17:44,676 DEBUG [main] BuildContext - path-alerts-config-update OK
2020-02-18 07:17:44,677 DEBUG [main] BuildContext - path-fin-dirs-update
2020-02-18 07:17:44,677 DEBUG [main] BuildContext - path-fin-dirs-update OK
2020-02-18 07:17:44,677 DEBUG [main] BuildContext - path-foundation-appserver-update
2020-02-18 07:17:44,687 DEBUG [main] BuildContext - path-foundation-appserver-update OK
2020-02-18 07:17:44,687 DEBUG [main] BuildContext - path-foundation-client-update
2020-02-18 07:17:44,696 DEBUG [main] BuildContext - path-foundation-client-update OK
2020-02-18 07:17:44,696 DEBUG [main] BuildContext - path-foundation-code-update
2020-02-18 07:17:44,701 DEBUG [main] BuildContext - path-foundation-code-update OK
2020-02-18 07:17:44,701 DEBUG [main] BuildContext - path-foundation-db-update
2020-02-18 07:17:44,707 DEBUG [main] BuildContext - path-foundation-db-update OK
2020-02-18 07:17:44,707 DEBUG [main] BuildContext - path-foundation-dirs-update
2020-02-18 07:17:44,708 DEBUG [main] BuildContext - path-foundation-dirs-update OK
2020-02-18 07:17:44,708 DEBUG [main] BuildContext - path-foundation-files-update
2020-02-18 07:17:44,708 DEBUG [main] BuildContext - path-foundation-files-update OK
2020-02-18 07:17:44,708 DEBUG [main] BuildContext - path-foundation-tmp-update
2020-02-18 07:17:44,709 DEBUG [main] PathUpdateProcess - chmod 777 /app/qad/uat/build/work/tmp
2020-02-18 07:17:44,711 DEBUG [main] BuildContext - path-foundation-tmp-update OK
2020-02-18 07:17:44,711 DEBUG [main] BuildContext - path-foundation-tomcat-update
2020-02-18 07:17:44,717 DEBUG [main] BuildContext - path-foundation-tomcat-update OK
2020-02-18 07:17:44,717 DEBUG [main] BuildContext - path-foundation-ws-update
2020-02-18 07:17:44,721 DEBUG [main] BuildContext - path-foundation-ws-update OK
2020-02-18 07:17:44,721 DEBUG [main] BuildContext - path-mfg-dirs-update
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-mfg-dirs-update OK
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-netui-dirs-update
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-netui-dirs-update OK
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-qra-dirs-update
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-qra-dirs-update OK
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-qxtend-customizations-dirs-update
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-qxtend-customizations-dirs-update OK
2020-02-18 07:17:44,722 DEBUG [main] BuildContext - path-qxtend-patches-dirs-update
2020-02-18 07:17:44,723 DEBUG [main] BuildContext - path-qxtend-patches-dirs-update OK
2020-02-18 07:17:44,723 DEBUG [main] BuildContext - path-update
2020-02-18 07:17:44,723 DEBUG [main] BuildContext - path-update OK
2020-02-18 07:17:44,723 DEBUG [main] BuildContext - daemon-reportdaemon-stop
2020-02-18 07:17:44,723 DEBUG [main] BuildContext - daemon-reportdaemon-stop OK
2020-02-18 07:17:44,723 DEBUG [main] BuildContext - fin-application-stop
2020-02-18 07:17:44,728 DEBUG [main] AsbmanBaseCommand - /app/progress/oe117/bin/asbman -i as-fin -query -port 24001
2020-02-18 07:17:44,757 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:17:45,754 DEBUG [Thread-4] STDOUT - Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:17:46,572 DEBUG [Thread-4] STDOUT - Searching for as-fin (8288)
2020-02-18 07:17:46,584 DEBUG [Thread-4] STDOUT - Connecting to as-fin  (8276)
2020-02-18 07:17:46,592 DEBUG [Thread-4] STDOUT - 
Broker Name                    : as-fin
Operating Mode                 : Stateless
Broker Status                  :  ACTIVE 
Broker Port                    : 24093
Broker PID                     : 21966
Active Servers                 : 5
Busy Servers                   : 0
Locked Servers                 : 0
Available Servers              : 5
Active Clients (now, peak)     : (6, 15)
Client Queue Depth (cur, max)  : (0, 0)
Total Requests                 : 3466
Rq Wait (max, avg)             : (1 ms, 0 ms)
Rq Duration (max, avg)         : (48163 ms, 199 ms)

PID   State     Port  nRq    nRcvd  nSent  Started          Last Change      
22004 AVAILABLE 24502 000714 000774 001441 Feb 16, 2020 20:51 Feb 17, 2020 19:51 
22006 AVAILABLE 24501 000667 000678 001268 Feb 16, 2020 20:51 Feb 17, 2020 20:04 
22010 AVAILABLE 24503 000682 000685 002291 Feb 16, 2020 20:51 Feb 17, 2020 19:51 
22014 AVAILABLE 24504 000727 000732 001464 Feb 16, 2020 20:51 Feb 17, 2020 19:51 
22016 AVAILABLE 24505 000706 000716 001526 Feb 16, 2020 20:51 Feb 17, 2020 20:04 
2020-02-18 07:17:46,646 DEBUG [main] DaemonControl - /bin/python /app/qad/uat/scripts/fin-application-stop
2020-02-18 07:17:57,370 DEBUG [Thread-4] STDOUT - 02/18/2020 07:17:46.852-05:00 > ExecuteAction Begin: Action= StopApplication
02/18/2020 07:17:57.358-05:00 > ExecuteAction end:   Action= StopApplication   *  ReturnStatus= 0  *  ErrorMsg=  
Return status: 0


2020-02-18 07:17:57,371 DEBUG [main] DaemonControl - Output from Daemon Status:02/18/2020 07:17:46.852-05:00 > ExecuteAction Begin: Action= StopApplication
02/18/2020 07:17:57.358-05:00 > ExecuteAction end:   Action= StopApplication   *  ReturnStatus= 0  *  ErrorMsg=  
Return status: 0

2020-02-18 07:17:57,372 DEBUG [main] BuildContext - fin-application-stop STOPPED
2020-02-18 07:17:57,372 DEBUG [main] BuildContext - elastic-stop
2020-02-18 07:17:57,372 DEBUG [main] BuildContext - elastic-stop OK
2020-02-18 07:17:57,372 DEBUG [main] BuildContext - qxo-services-stop
2020-02-18 07:17:57,374 DEBUG [main] QxoServicesStopProcess - /app/qad/uat/dist/qxoserver/scripts/sess-control.sh QUERY ALL
2020-02-18 07:17:57,492 DEBUG [main] QxoServicesStopProcess - ===========================
 SERVICE SESSION STATUS
===========================
STARTING:   0
IDLE:       4
BUSY:       0
SUSPENDED:  0
DEAD:       0
===========================
 SOURCE APPLICATION STATUS
===========================
ACTIVE:     1
SUSPENDED:  0
===========================
 SUBSCRIBER STATUS
===========================
ACTIVE:     1
SUSPENDED:  0
===========================

2020-02-18 07:17:57,492 DEBUG [main] QxoServicesStopProcess - /app/qad/uat/dist/qxoserver/scripts/sess-control.sh STOP ALL
2020-02-18 07:17:57,674 DEBUG [main] QxoServicesStopProcess - 02/18/2020 07:17:57.668-05:00 All services successfully stopped.

2020-02-18 07:17:57,674 DEBUG [main] BuildContext - qxo-services-stop STOPPED
2020-02-18 07:17:57,674 DEBUG [main] BuildContext - tomcat-default-stop
2020-02-18 07:17:57,742 DEBUG [main] PortAvailabilityCommand - Opened a client socket [8080].
2020-02-18 07:17:57,743 DEBUG [main] TomcatStopProcess - /bin/python /app/qad/uat/scripts/tomcat-default-stop
2020-02-18 07:18:04,533 DEBUG [Thread-4] STDOUT - Tomcat did not stop in time.
To aid diagnostics a thread dump has been written to standard out.
Killing Tomcat with the PID: 22998
The Tomcat process has been killed.


2020-02-18 07:18:04,535 DEBUG [main] BuildContext - tomcat-default-stop STOPPED
2020-02-18 07:18:04,535 DEBUG [main] BuildContext - tomcat-qxtend-stop
2020-02-18 07:18:04,541 DEBUG [main] PortAvailabilityCommand - Opened a client socket [8085].
2020-02-18 07:18:04,541 DEBUG [main] TomcatStopProcess - /bin/python /app/qad/uat/scripts/tomcat-qxtend-stop
2020-02-18 07:18:10,901 DEBUG [Thread-4] STDOUT - Tomcat did not stop in time.
To aid diagnostics a thread dump has been written to standard out.
Killing Tomcat with the PID: 23026
The Tomcat process has been killed.


2020-02-18 07:18:10,902 DEBUG [main] BuildContext - tomcat-qxtend-stop STOPPED
2020-02-18 07:18:10,902 DEBUG [main] BuildContext - tomcat-stop
2020-02-18 07:18:10,902 DEBUG [main] BuildContext - tomcat-stop OK
2020-02-18 07:18:10,902 DEBUG [main] BuildContext - webspeed-default-stop
2020-02-18 07:18:11,328 DEBUG [main] WebspeedServerStopProcess - /bin/python /app/qad/uat/scripts/webspeed-default-stop
2020-02-18 07:18:12,742 DEBUG [Thread-5] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018


Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
Searching for ws-default (8288)
Connecting to ws-default  (8276)
Shut down ws-default (8277)


2020-02-18 07:18:12,742 DEBUG [main] BuildContext - webspeed-default-stop STOPPED
2020-02-18 07:18:12,742 DEBUG [main] BuildContext - webspeed-stop
2020-02-18 07:18:12,742 DEBUG [main] BuildContext - webspeed-stop OK
2020-02-18 07:18:12,742 DEBUG [main] BuildContext - appserver-fin-stop
2020-02-18 07:18:13,150 DEBUG [main] ApplicationServerStopProcess - /bin/python /app/qad/uat/scripts/appserver-fin-stop
2020-02-18 07:18:13,561 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:18:13,722 DEBUG [Thread-4] STDOUT - 
Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:18:13,888 DEBUG [Thread-4] STDOUT - Searching for as-fin (8288)
2020-02-18 07:18:13,895 DEBUG [Thread-4] STDOUT - Connecting to as-fin  (8276)
2020-02-18 07:18:16,903 DEBUG [Thread-4] STDOUT - Shut down as-fin (8277)
2020-02-18 07:18:19,617 DEBUG [main] BuildContext - appserver-fin-stop STOPPED
2020-02-18 07:18:19,617 DEBUG [main] BuildContext - appserver-mfg-stop
2020-02-18 07:18:20,029 DEBUG [main] ApplicationServerStopProcess - /bin/python /app/qad/uat/scripts/appserver-mfg-stop
2020-02-18 07:18:20,412 DEBUG [Thread-5] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:18:20,552 DEBUG [Thread-5] STDOUT - 
Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:18:20,706 DEBUG [Thread-5] STDOUT - Searching for as-mfg (8288)
2020-02-18 07:18:20,713 DEBUG [Thread-5] STDOUT - Connecting to as-mfg  (8276)
2020-02-18 07:18:21,718 DEBUG [Thread-5] STDOUT - Shut down as-mfg (8277)
2020-02-18 07:18:24,143 DEBUG [main] BuildContext - appserver-mfg-stop STOPPED
2020-02-18 07:18:24,143 DEBUG [main] BuildContext - appserver-qra-stop
2020-02-18 07:18:24,554 DEBUG [main] ApplicationServerStopProcess - /bin/python /app/qad/uat/scripts/appserver-qra-stop
2020-02-18 07:18:24,942 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:18:25,093 DEBUG [Thread-4] STDOUT - 
Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:18:25,253 DEBUG [Thread-4] STDOUT - Searching for as-qra (8288)
2020-02-18 07:18:25,259 DEBUG [Thread-4] STDOUT - Connecting to as-qra  (8276)
2020-02-18 07:18:26,265 DEBUG [Thread-4] STDOUT - Shut down as-qra (8277)
2020-02-18 07:18:28,602 DEBUG [main] BuildContext - appserver-qra-stop STOPPED
2020-02-18 07:18:28,602 DEBUG [main] BuildContext - appserver-qxosi-stop
2020-02-18 07:18:29,011 DEBUG [main] ApplicationServerStopProcess - /bin/python /app/qad/uat/scripts/appserver-qxosi-stop
2020-02-18 07:18:29,389 DEBUG [Thread-5] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:18:29,533 DEBUG [Thread-5] STDOUT - 
Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:18:29,703 DEBUG [Thread-5] STDOUT - Searching for as-qxo-si (8288)
2020-02-18 07:18:29,710 DEBUG [Thread-5] STDOUT - Connecting to as-qxo-si  (8276)
2020-02-18 07:18:30,717 DEBUG [Thread-5] STDOUT - Shut down as-qxo-si (8277)
2020-02-18 07:18:33,038 DEBUG [main] BuildContext - appserver-qxosi-stop STOPPED
2020-02-18 07:18:33,039 DEBUG [main] BuildContext - appserver-qxoui-stop
2020-02-18 07:18:33,448 DEBUG [main] ApplicationServerStopProcess - /bin/python /app/qad/uat/scripts/appserver-qxoui-stop
2020-02-18 07:18:33,851 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:18:34,011 DEBUG [Thread-4] STDOUT - 
Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:18:34,174 DEBUG [Thread-4] STDOUT - Searching for as-qxo-ui (8288)
2020-02-18 07:18:34,182 DEBUG [Thread-4] STDOUT - Connecting to as-qxo-ui  (8276)
2020-02-18 07:18:35,187 DEBUG [Thread-4] STDOUT - Shut down as-qxo-ui (8277)
2020-02-18 07:18:37,553 DEBUG [main] BuildContext - appserver-qxoui-stop STOPPED
2020-02-18 07:18:37,553 DEBUG [main] BuildContext - appserver-qxtnative-stop
2020-02-18 07:18:37,963 DEBUG [main] ApplicationServerStopProcess - /bin/python /app/qad/uat/scripts/appserver-qxtnative-stop
2020-02-18 07:18:38,334 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:18:38,477 DEBUG [Thread-4] STDOUT - 
Connecting to Progress AdminServer using rmi://localhost:24001/Chimera (8280)
2020-02-18 07:18:38,620 DEBUG [Thread-4] STDOUT - Searching for as-qxtsi (8288)
2020-02-18 07:18:38,627 DEBUG [Thread-4] STDOUT - Connecting to as-qxtsi  (8276)
2020-02-18 07:18:39,632 DEBUG [Thread-4] STDOUT - Shut down as-qxtsi (8277)
2020-02-18 07:18:41,973 DEBUG [main] BuildContext - appserver-qxtnative-stop STOPPED
2020-02-18 07:18:41,973 DEBUG [main] BuildContext - appserver-stop
2020-02-18 07:18:41,973 DEBUG [main] BuildContext - appserver-stop OK
2020-02-18 07:18:41,973 DEBUG [main] BuildContext - database-alerts-stop
2020-02-18 07:18:41,991 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-alerts-stop
2020-02-18 07:18:48,106 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:18:48,107 DEBUG [main] BuildContext - database-alerts-stop STOPPED
2020-02-18 07:18:48,107 DEBUG [main] BuildContext - database-custom-stop
2020-02-18 07:18:48,133 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-custom-stop
2020-02-18 07:18:54,216 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:18:54,218 DEBUG [main] BuildContext - database-custom-stop STOPPED
2020-02-18 07:18:54,218 DEBUG [main] BuildContext - database-qadadm-stop
2020-02-18 07:18:54,243 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-qadadm-stop
2020-02-18 07:19:00,407 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:19:00,409 DEBUG [main] BuildContext - database-qadadm-stop STOPPED
2020-02-18 07:19:00,409 DEBUG [main] BuildContext - database-qaddb-stop
2020-02-18 07:19:00,432 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-qaddb-stop
2020-02-18 07:19:06,610 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:19:06,612 DEBUG [main] BuildContext - database-qaddb-stop STOPPED
2020-02-18 07:19:06,612 DEBUG [main] BuildContext - database-qadhlp-stop
2020-02-18 07:19:06,630 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-qadhlp-stop
2020-02-18 07:19:12,714 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:19:12,716 DEBUG [main] BuildContext - database-qadhlp-stop STOPPED
2020-02-18 07:19:12,717 DEBUG [main] BuildContext - database-qxevents-stop
2020-02-18 07:19:12,743 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-qxevents-stop
2020-02-18 07:19:18,832 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:19:18,833 DEBUG [main] BuildContext - database-qxevents-stop STOPPED
2020-02-18 07:19:18,833 DEBUG [main] BuildContext - database-qxodb-stop
2020-02-18 07:19:18,851 DEBUG [main] DatabaseServerStopProcess - /bin/python /app/qad/uat/scripts/database-qxodb-stop
2020-02-18 07:19:24,927 DEBUG [Thread-4] STDOUT - Shutdown is executing. (1613)
Shutdown complete. (1614)


2020-02-18 07:19:24,928 DEBUG [main] BuildContext - database-qxodb-stop STOPPED
2020-02-18 07:19:24,928 DEBUG [main] BuildContext - database-stop
2020-02-18 07:19:24,928 DEBUG [main] BuildContext - database-stop OK
2020-02-18 07:19:24,928 DEBUG [main] BuildContext - nameserver-stop
2020-02-18 07:19:24,928 DEBUG [main] NameServerStopProcess - Nameserver will be automatically stopped by the adminserver.
2020-02-18 07:19:24,929 DEBUG [main] BuildContext - nameserver-stop OK
2020-02-18 07:19:24,929 DEBUG [main] BuildContext - adminserver-stop
2020-02-18 07:19:26,021 DEBUG [main] AdminServerStopProcess - /bin/python /app/qad/uat/scripts/adminserver-stop
2020-02-18 07:19:30,762 DEBUG [Thread-5] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
Requesting shutdown of admin server. (7422)
Shutdown complete. (7420)


2020-02-18 07:19:30,764 DEBUG [main] BuildContext - adminserver-stop STOPPED
2020-02-18 07:19:30,764 DEBUG [main] BuildContext - foundation-stop
2020-02-18 07:19:30,764 DEBUG [main] BuildContext - foundation-stop OK
2020-02-18 07:19:30,764 DEBUG [main] BuildContext - stop
2020-02-18 07:19:30,764 DEBUG [main] BuildContext - stop OK
2020-02-18 07:19:30,764 DEBUG [main] BuildContext - clean-tmp
2020-02-18 07:19:30,766 DEBUG [main] Exec - /app/qad/uat/localYab/scripts/clean-tmp.sh /app/qad/uat/build/work/tmp
2020-02-18 07:19:30,901 DEBUG [main] BuildContext - clean-tmp OK
2020-02-18 07:19:30,901 DEBUG [main] BuildContext - pf-foundation-update
2020-02-18 07:19:30,914 DEBUG [main] BuildContext - pf-foundation-update OK
2020-02-18 07:19:30,915 DEBUG [main] BuildContext - tomcat-default-update
2020-02-18 07:19:30,918 DEBUG [main] TomcatUpdateProcess - Work file of [tomcat.default] has no changes.
2020-02-18 07:19:30,918 DEBUG [main] BuildContext - tomcat-default-update OK
2020-02-18 07:19:30,918 DEBUG [main] BuildContext - tomcat-qxtend-update
2020-02-18 07:19:30,921 DEBUG [main] TomcatUpdateProcess - Work file of [tomcat.qxtend] has no changes.
2020-02-18 07:19:30,921 DEBUG [main] BuildContext - tomcat-qxtend-update OK
2020-02-18 07:19:30,921 DEBUG [main] BuildContext - tomcat-update
2020-02-18 07:19:30,921 DEBUG [main] BuildContext - tomcat-update OK
2020-02-18 07:19:30,921 DEBUG [main] BuildContext - webapp-api-update
2020-02-18 07:19:30,938 DEBUG [main] GenericFileDeploymentProcess - No changes.
2020-02-18 07:19:30,938 DEBUG [main] BuildContext - webapp-api-update SKIPPED
2020-02-18 07:19:30,938 DEBUG [main] BuildContext - webapp-fin-api-update
2020-02-18 07:19:31,377 DEBUG [main] GenericFileDeploymentProcess - No changes.
2020-02-18 07:19:31,377 DEBUG [main] BuildContext - webapp-fin-api-update SKIPPED
2020-02-18 07:19:31,377 DEBUG [main] BuildContext - webapp-fin-api-configuration
2020-02-18 07:19:31,418 DEBUG [main] BuildContext - webapp-fin-api-configuration OK
2020-02-18 07:19:31,418 DEBUG [main] BuildContext - webapp-api-configuration
2020-02-18 07:19:31,423 DEBUG [main] BuildContext - webapp-api-configuration OK
2020-02-18 07:19:31,423 DEBUG [main] BuildContext - fin-server-xml-update
2020-02-18 07:19:31,432 DEBUG [main] BuildContext - fin-server-xml-update SKIPPED
2020-02-18 07:19:31,432 DEBUG [main] BuildContext - fin-cbserver-xml-update
2020-02-18 07:19:31,433 DEBUG [main] BuildContext - fin-cbserver-xml-update SKIPPED
2020-02-18 07:19:31,434 DEBUG [main] BuildContext - language-dat-files-update
2020-02-18 07:19:31,434 DEBUG [main] BuildContext - language-dat-files-update OK
2020-02-18 07:19:31,434 DEBUG [main] BuildContext - nameserver-update
2020-02-18 07:19:31,444 DEBUG [main] BuildContext - nameserver-update OK
2020-02-18 07:19:31,444 DEBUG [main] BuildContext - database-alerts-structure-list
2020-02-18 07:19:31,446 DEBUG [main] DatabaseStructureActionCommand - /app/progress/oe117/bin/prostrct list /db/uat/alerts/altuat
2020-02-18 07:19:31,464 DEBUG [main] DatabaseStructureListProcess - Generated [/db/uat/alerts/altuat.st].
2020-02-18 07:19:31,464 DEBUG [main] BuildContext - database-alerts-structure-list OK
2020-02-18 07:19:31,464 DEBUG [main] BuildContext - database-alerts-structure-file-update
2020-02-18 07:19:31,465 DEBUG [main] BuildContext - database-alerts-structure-file-update SKIPPED
2020-02-18 07:19:31,465 DEBUG [main] BuildContext - database-alerts-structure-validate
2020-02-18 07:19:31,467 DEBUG [main] BuildContext - database-alerts-structure-validate OK
2020-02-18 07:19:31,467 DEBUG [main] BuildContext - database-alerts-create
2020-02-18 07:19:31,469 DEBUG [main] BuildContext - database-alerts-create OK
2020-02-18 07:19:31,469 DEBUG [main] BuildContext - database-alerts-structure-update
2020-02-18 07:19:31,469 DEBUG [main] BuildContext - database-alerts-structure-update OK
2020-02-18 07:19:31,470 DEBUG [main] BuildContext - replace-token-file-update
2020-02-18 07:19:31,478 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/build/work/system/processes/alerts-stage/ReplaceTokens.properties] from the template [/app/qad/uat/build/catalog/packages/yab-alerts/1/6/3/0/etc/ReplaceTokens.properties].
2020-02-18 07:19:31,478 DEBUG [main] BuildContext - replace-token-file-update OK
2020-02-18 07:19:31,478 DEBUG [main] BuildContext - alerts-db-user-config
2020-02-18 07:19:31,479 DEBUG [main] BuildContext - alerts-db-user-config OK
2020-02-18 07:19:31,479 DEBUG [main] BuildContext - update-admin-user-file-update
2020-02-18 07:19:31,489 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/build/work/system/processes/alerts-stage/Update-Alerts-Database-Admin-User.sql] from the template [/app/qad/uat/build/catalog/packages/yab-alerts/1/6/3/0/etc/Update-Alerts-Database-Admin-User.sql].
2020-02-18 07:19:31,490 DEBUG [main] BuildContext - update-admin-user-file-update OK
2020-02-18 07:19:31,490 DEBUG [main] BuildContext - update-workflow-user-file-update
2020-02-18 07:19:31,498 DEBUG [main] TemplateEngine - Generated the file [/app/qad/uat/build/work/system/processes/alerts-stage/Update-Alerts-Database-Workflow-User.sql] from the template [/app/qad/uat/build/catalog/packages/yab-alerts/1/6/3/0/etc/Update-Alerts-Database-Workflow-User.sql].
2020-02-18 07:19:31,499 DEBUG [main] BuildContext - update-workflow-user-file-update OK
2020-02-18 07:19:31,499 DEBUG [main] BuildContext - database-alerts-schema-update
2020-02-18 07:19:31,580 DEBUG [main] Ant - Script: com/qad/yab/alerts/AlertsDatabaseInstallProcess.xml
2020-02-18 07:19:31,580 DEBUG [main] Ant - Targets: [replace-tokens]
2020-02-18 07:19:31,966 DEBUG [main] BuildContext - database-alerts-schema-update OK
2020-02-18 07:19:31,966 DEBUG [main] BuildContext - database-alerts-schema-index-rebuild
2020-02-18 07:19:31,969 DEBUG [main] DatabaseIndexRebuildCommand - Explicit request for index rebuild type [IDXBUILD].
2020-02-18 07:19:31,970 DEBUG [main] DatabaseIndexRebuildCommand - sh -c "/app/progress/oe117/bin/proutil "/db/uat/alerts/altuat" -C idxbuild -TB 24 -TM 32 -TF 50 -B 512 -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic < "/tmp/3987554725772725416/4975600945694284400""
2020-02-18 07:19:32,344 DEBUG [main] DatabaseIndexRebuildCommand - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018

The BI file is being automatically truncated. (1526)

Index Rebuild Utility
=====================

Select one of the following:
--------------------
All           (a/A) - Choose all the indexes
Some          (s/S) - Choose only some of the indexes
By Area       (r/R) - Choose indexes in selected areas
By Schema     (c/C) - Choose indexes by schema owners
By Table      (t/T) - Choose indexes in selected tables
By Activation (v/V) - Choose active or inactive indexes
--------------------
Quit          (q/Q)

Enter your selection:

1.    Choose active indexes
2.    Choose inactive indexes
No index was found. (16274)
Index rebuild did not complete successfully

2020-02-18 07:19:32,345 INFO  [main] DatabaseIndexRebuildCommand - Execute the proutil command succeeded. Database index rebuilding finished.
2020-02-18 07:19:32,345 DEBUG [main] DatabaseIndexRebuildCommand - Execute:[/app/progress/oe117/bin/proutil "/db/uat/alerts/altuat" -C idxbuild -TB 24 -TM 32 -TF 50 -B 512 -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic < "/tmp/3987554725772725416/4975600945694284400"], ExitCode:[0]
2020-02-18 07:19:32,345 DEBUG [main] BuildContext - database-alerts-schema-index-rebuild OK
2020-02-18 07:19:32,345 DEBUG [main] BuildContext - database-alerts-data-xml-update
2020-02-18 07:19:32,348 DEBUG [main] DatabaseDataXmlUpdateProcess - No changes.
2020-02-18 07:19:32,348 DEBUG [main] BuildContext - database-alerts-data-xml-update SKIPPED
2020-02-18 07:19:32,348 DEBUG [main] BuildContext - database-alerts-data-dotd-update
2020-02-18 07:19:32,368 DEBUG [main] OpenEdgeDataLoadCommand - No changes [/app/qad/uat/build/catalog/packages/yab-ee-foundation/1/6/7/3/etc].
2020-02-18 07:19:32,368 DEBUG [main] BuildContext - database-alerts-data-dotd-update OK
2020-02-18 07:19:32,368 DEBUG [main] BuildContext - database-alerts-data-update
2020-02-18 07:19:32,368 DEBUG [main] BuildContext - database-alerts-data-update OK
2020-02-18 07:19:32,368 DEBUG [main] BuildContext - database-alerts-jta-enable
2020-02-18 07:19:32,370 DEBUG [main] DatabaseJTAStatusCommand - /app/progress/oe117/bin/proutil /db/uat/alerts/altuat -C describe
2020-02-18 07:19:32,400 DEBUG [main] DatabaseJTAStatusCommand - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018

 
OpenEdge Database Description
 
Database Name               : /db/uat/alerts/altuat
Version                     : 173.0
Block Size                  : 4096
Largest Cluster             : 8
Create Date                 : Mon Nov 26 13:33:15 2018
Last Open Date              : Tue Feb 18 07:19:33 2020
Prior Open Date             : Tue Feb 18 07:19:33 2020
Schema Change Date          : Mon Nov 26 13:33:37 2018
 
Before Imaging information
  Block Size                : 16384
  Cluster Size (16K Units)  : 1024
  Last Open Date            : Tue Feb 18 07:19:32 2020
 
Backup Information
  Last Full Backup Date     : Mon Feb 17 22:00:02 2020
  Last Incremental Backup   : *** Not yet performed ***
 
Database Features
 
   ID   Feature                            Active  Details
  ----  ---------------------------------  ------  -------
     5  Large Files                        Yes      
     7  JTA                                Yes      
     9  64 Bit DBKEYS                      Yes      
    10  Large Keys                         Yes      
    11  64 Bit Sequences                   Yes      
    23  New VST Tables                     Yes      
 

2020-02-18 07:19:32,401 DEBUG [main] BuildContext - database-alerts-jta-enable SKIPPED
2020-02-18 07:19:32,401 DEBUG [main] BuildContext - database-alerts-update
2020-02-18 07:19:32,401 DEBUG [main] BuildContext - database-alerts-update OK
2020-02-18 07:19:32,401 DEBUG [main] BuildContext - database-custom-structure-list
2020-02-18 07:19:32,402 DEBUG [main] DatabaseStructureActionCommand - /app/progress/oe117/bin/prostrct list /db/uat/cust/cusuat
2020-02-18 07:19:32,425 DEBUG [main] DatabaseStructureListProcess - Generated [/db/uat/cust/cusuat.st].
2020-02-18 07:19:32,425 DEBUG [main] BuildContext - database-custom-structure-list OK
2020-02-18 07:19:32,426 DEBUG [main] BuildContext - database-custom-structure-file-update
2020-02-18 07:19:32,426 DEBUG [main] BuildContext - database-custom-structure-file-update SKIPPED
2020-02-18 07:19:32,426 DEBUG [main] BuildContext - database-custom-structure-validate
2020-02-18 07:19:32,428 DEBUG [main] BuildContext - database-custom-structure-validate OK
2020-02-18 07:19:32,428 DEBUG [main] BuildContext - database-custom-create
2020-02-18 07:19:32,429 DEBUG [main] BuildContext - database-custom-create OK
2020-02-18 07:19:32,429 DEBUG [main] BuildContext - database-custom-structure-update
2020-02-18 07:19:32,431 DEBUG [main] BuildContext - database-custom-structure-update OK
2020-02-18 07:19:32,431 DEBUG [main] BuildContext - database-custom-schema-update
2020-02-18 07:19:32,439 DEBUG [main] DatabaseSchemaProcess - Schema Files [/app/qad/uat/customizations/schema/custom/CR8735-1-Triggers.df, /app/qad/uat/customizations/schema/custom/custom.df].
2020-02-18 07:19:32,439 DEBUG [main] DatabaseSchemaProcess - Evaluating schema.
2020-02-18 07:19:32,440 DEBUG [main] DatabaseSchemaProcess - Calculating delta schema.
2020-02-18 07:19:32,442 DEBUG [main] DatabaseStructureActionCommand - /app/progress/oe117/bin/prostrct list /db/uat/cust/cusuat
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT - Area Name: Control Area, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 1, Type VARIABLE, Size 320 KByte, Name: /db/uat/cust/cusuat.db

Area Name: Primary Recovery Area, Type 3, Block Size 8192, Extents 5
   Ext # 1, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b1
   Ext # 2, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b2
   Ext # 3, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b3
   Ext # 4, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b4
   Ext # 5, Type VARIABLE, Size 8 KByte, Name: /db/uat/cust/cusuat.b5

Area Name: Schema Area, Type 6, Block Size 4096, Extents 2, Records/Block 32, Cluster Size 1
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 1, Type FIXED   , Size 256000 KByte, Name: /db/uat/cust/cusuat.d1
   Ext # 2, Type VARIABLE, Size 64 KByte, Name: /db/uat/cust/cusuat.d2

Area Name: INV, Type 6, Block Size 4096, Extents 7, Records/Block 64, Cluster Size 64
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d1
   Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d4
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d6
   Ext # 7, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_7.d7

Area Name: INV_IDX, Type 6, Block Size 4096, Extents 6, Records/Block 64, Cluster Size 64
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d1
   Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d3
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d5
   Ext # 6, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_8.d6

Area Name: MISC, Type 6, Block Size 4096, Extents 30, Records/Block 64, Cluster Size 64
2020-02-18 07:19:32,455 DEBUG [Thread-4] STDOUT -    Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d1
   Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d3
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d4
   Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d5
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d6
   Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d7
   Ext # 8, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d8
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 9, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d9
   Ext # 10, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d10
   Ext # 11, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d11
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 12, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d12
   Ext # 13, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d13
   Ext # 14, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d14
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 15, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d15
   Ext # 16, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d16
   Ext # 17, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d17
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 18, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d18
   Ext # 19, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d19
   Ext # 20, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d20
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 21, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d21
   Ext # 22, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d22
   Ext # 23, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d23
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 24, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d24
   Ext # 25, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d25
   Ext # 26, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d26
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 27, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d27
   Ext # 28, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d28
   Ext # 29, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d29
   Ext # 30, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_9.d30

Area Name: MISC_IDX, Type 6, Block Size 4096, Extents 12, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d1
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d5
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 6, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d6
   Ext # 7, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d7
   Ext # 8, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d8
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 9, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d9
   Ext # 10, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d10
   Ext # 11, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d11
   Ext # 12, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_10.d12

Area Name: ORDER, Type 6, Block Size 4096, Extents 12, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d1
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d4
   Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d5
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d6
   Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d7
   Ext # 8, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d8
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 9, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d9
   Ext # 10, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d10
   Ext # 11, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d11
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 12, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_11.d12

Area Name: ORDER_IDX, Type 6, Block Size 4096, Extents 6, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d1
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d3
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d5
   Ext # 6, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_12.d6
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT - 
Area Name: RGA, Type 6, Block Size 4096, Extents 12, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d1
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d4
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d6
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d7
   Ext # 8, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d8
   Ext # 9, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d9
2020-02-18 07:19:32,456 DEBUG [Thread-4] STDOUT -    Ext # 10, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d10
   Ext # 11, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d11
   Ext # 12, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_13.d12

Area Name: RGA_IDX, Type 6, Block Size 4096, Extents 10, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d1
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d5
   Ext # 6, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d6
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 7, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d7
   Ext # 8, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d8
   Ext # 9, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d9
   Ext # 10, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_14.d10

Area Name: SHIP, Type 6, Block Size 4096, Extents 8, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d1
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d4
   Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d5
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d6
   Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d7
   Ext # 8, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_15.d8

Area Name: SHIP_IDX, Type 6, Block Size 4096, Extents 7, Records/Block 64, Cluster Size 64
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d1
   Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d3
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d5
2020-02-18 07:19:32,457 DEBUG [Thread-4] STDOUT -    Ext # 6, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d6
   Ext # 7, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_16.d7

2020-02-18 07:19:32,463 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/_dbutil prostrct create installed /tmp/3987554725772725416/5746533319554859938/simplified.st -blocksize 4096
2020-02-18 07:19:32,481 DEBUG [Thread-4] STDOUT - 
Formatting extents:
   size                area name   path name
2020-02-18 07:19:32,481 DEBUG [Thread-4] STDOUT -       8    Primary Recovery Area /tmp/3987554725772725416/6076747435758064451/installed.b1 00:00:00
2020-02-18 07:19:32,481 DEBUG [Thread-4] STDOUT -      16              Schema Area /tmp/3987554725772725416/6076747435758064451/installed.d1 00:00:00
2020-02-18 07:19:32,481 DEBUG [Thread-4] STDOUT -      16                      INV /tmp/3987554725772725416/6076747435758064451/installed_7.d1 00:00:00
2020-02-18 07:19:32,481 DEBUG [Thread-4] STDOUT -      16                  INV_IDX /tmp/3987554725772725416/6076747435758064451/installed_8.d1 00:00:00
2020-02-18 07:19:32,481 DEBUG [Thread-4] STDOUT -      16                     MISC /tmp/3987554725772725416/6076747435758064451/installed_9.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                 MISC_IDX /tmp/3987554725772725416/6076747435758064451/installed_10.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                    ORDER /tmp/3987554725772725416/6076747435758064451/installed_11.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                ORDER_IDX /tmp/3987554725772725416/6076747435758064451/installed_12.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                      RGA /tmp/3987554725772725416/6076747435758064451/installed_13.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                  RGA_IDX /tmp/3987554725772725416/6076747435758064451/installed_14.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                     SHIP /tmp/3987554725772725416/6076747435758064451/installed_15.d1 00:00:00
2020-02-18 07:19:32,482 DEBUG [Thread-4] STDOUT -      16                 SHIP_IDX /tmp/3987554725772725416/6076747435758064451/installed_16.d1 00:00:00
2020-02-18 07:19:32,495 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/_dbutil procopy /app/progress/oe117/prolang/utf/empty4 installed -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:32,514 DEBUG [Thread-5] STDOUT - Procopy session begin for mfg on batch. (451)
2020-02-18 07:19:32,545 DEBUG [Thread-5] STDOUT - 
Copying /app/progress/oe117/prolang/utf/empty4 to installed... (6715)
2020-02-18 07:19:32,545 DEBUG [Thread-5] STDOUT - 
Start writing data blocks. (6718)
2020-02-18 07:19:32,550 DEBUG [Thread-5] STDOUT - 07:19:32 10 Percent complete.
2020-02-18 07:19:32,554 DEBUG [Thread-5] STDOUT - 07:19:32 20 Percent complete.
2020-02-18 07:19:32,554 DEBUG [Thread-5] STDOUT - 07:19:32 30 Percent complete.
2020-02-18 07:19:32,556 DEBUG [Thread-5] STDOUT - 07:19:32 40 Percent complete.
2020-02-18 07:19:32,557 DEBUG [Thread-5] STDOUT - 07:19:32 50 Percent complete.
2020-02-18 07:19:32,558 DEBUG [Thread-5] STDOUT - 07:19:32 60 Percent complete.
2020-02-18 07:19:32,558 DEBUG [Thread-5] STDOUT - 07:19:32 70 Percent complete.
2020-02-18 07:19:32,558 DEBUG [Thread-5] STDOUT - 07:19:32 80 Percent complete.
2020-02-18 07:19:32,559 DEBUG [Thread-5] STDOUT - 07:19:32 90 Percent complete.
2020-02-18 07:19:32,559 DEBUG [Thread-5] STDOUT - 07:19:32 100 Percent complete.
520 blocks copied. (6720)

...Copy complete. (6722)
2020-02-18 07:19:32,705 DEBUG [Thread-5] STDOUT - Database copied from /app/progress/oe117/prolang/utf/empty4. (1365)
2020-02-18 07:19:32,712 DEBUG [Thread-5] STDOUT - Procopy session end. (334)
2020-02-18 07:19:32,714 DEBUG [main] DatabaseStructureActionCommand - /app/progress/oe117/bin/prostrct list /tmp/3987554725772725416/6076747435758064451/installed
2020-02-18 07:19:32,729 DEBUG [Thread-4] STDOUT - Area Name: Control Area, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
2020-02-18 07:19:32,729 DEBUG [Thread-4] STDOUT -    Ext # 1, Type VARIABLE, Size 32 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed.db

Area Name: Primary Recovery Area, Type 3, Block Size 8192, Extents 1
   Ext # 1, Type VARIABLE, Size 2176 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed.b1

Area Name: Schema Area, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 2112 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed.d1
2020-02-18 07:19:32,729 DEBUG [Thread-4] STDOUT - 
Area Name: INV, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_7.d1

Area Name: INV_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_8.d1

Area Name: MISC, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_9.d1

Area Name: MISC_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_10.d1

Area Name: ORDER, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
2020-02-18 07:19:32,729 DEBUG [Thread-4] STDOUT -    Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_11.d1

Area Name: ORDER_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_12.d1

Area Name: RGA, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_13.d1

Area Name: RGA_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_14.d1

Area Name: SHIP, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
2020-02-18 07:19:32,729 DEBUG [Thread-4] STDOUT -    Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_15.d1

Area Name: SHIP_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/installed_16.d1

2020-02-18 07:19:32,732 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/proutil /tmp/3987554725772725416/6076747435758064451/installed -C truncate bi -biblocksize 8 -bi 512 -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:32,735 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:19:32,755 DEBUG [Thread-4] STDOUT - Before-image cluster size set to 512 kb. (1620)
2020-02-18 07:19:32,756 DEBUG [Thread-4] STDOUT - Before-image block size set to 8 kb (8192 bytes). (3781)
2020-02-18 07:19:32,766 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/_rfutil /tmp/3987554725772725416/6076747435758064451/installed -C aimage truncate -aiblocksize 8 -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:32,918 DEBUG [Thread-5] STDOUT - The AI file is being truncated. (287)
After-image block size set to 8 kb (8192 bytes). (644)
2020-02-18 07:19:32,919 DEBUG [Thread-5] STDOUT - Truncation complete. (292)
2020-02-18 07:19:32,927 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/proutil /tmp/3987554725772725416/6076747435758064451/installed -C EnableLargeFiles -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:32,931 DEBUG [Thread-5] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:19:32,953 DEBUG [Thread-5] STDOUT - Large database file access enabled for database /tmp/3987554725772725416/6076747435758064451/installed. (9425)
2020-02-18 07:19:33,024 DEBUG [main] ProgressProgramExecutor - /app/progress/oe117/bin/_progres -pf /tmp/3987554725772725416/4030156309046410077.pf -h 1 -T /tmp -b -param false,false -p /tmp/3987554725772725416/7640824562558990257/dump-tableinfo.p
2020-02-18 07:19:33,723 DEBUG [main] DatabaseSchemaProcess - Dumping 86 tables from [cusuat] to [/tmp/3987554725772725416/6886584284431866807].
2020-02-18 07:19:33,744 DEBUG [main] ProgressProgramExecutor - /app/progress/oe117/bin/_progres -pf /tmp/3987554725772725416/6015282114302581339.pf -cpstream utf-8 -cpinternal utf-8 -d mdy -yy 1950 -numsep 44 -numdec 46 -T /tmp -b -param /tmp/3987554725772725416/6465695605734405444.args -p /tmp/3987554725772725416/290096125074942749/dump-schema.p
2020-02-18 07:19:33,790 DEBUG [Thread-5] STDOUT - Dumping tables: xdmrd_det,xwr_route,xedgfd_det,xpl_xref,xspc_cal,xatp_audit,xptctry_mstr,xtpr_mstr,xlad_det,xedgf_mstr,xfcstx_stat,xpro_det,xprog_audit,xtur_det,xcp_mstr,xrecon_mstr,xpt_mstr,xvdc_det,xvd_mstr,xspad_det,xspt_turn,xspa_cal,xrslt_mstr,xktord_det,xspt2_turn,xbill_inv,xcapd_det,xcimerror_det,xide_mstr,xwoc_clean,xpoall_det,xsrgx_xref,xptlbl_mstr,xtax_mstr,xbca_audit,xrga_mstr,xwod_det,xfcstc_cust,xbdm_det,xkrd_det,xto_mstr,xsp_mstr,xret_code,xbd_mstr,xrgad_det,xcap_prc,xfcstb_bld,xtod_det,xbcd_det,xfrlppr_mstr,xbod_det,xsttax_det,xlabel_hist,xspcd_det,xbo_mstr,xxpcm_det,xfrtupl_mstr,xfrtips_mstr,xptx_xref,xart_det,xjcm_mstr,xsrg_mstr,xwo_scan,xcd_mstr,xcprf_fcst,xlnkd_det,xtocd_det,xtotd_det,xvdq_det,xlbl_mstr,xserh_hist,xbda_det,xfrtupld_det,xfcstd_det,xrgah_hist,xord_mstr,xtprd_det,xsopo_abn,xidesrg_det,xspf_frt,xrsld_det,xser_det,xidept_det,xsos_mstr,xfcst_mstr,xloc_mstr
2020-02-18 07:19:34,146 DEBUG [main] DatabaseSchemaProcess - Loading 86 tables from [/tmp/3987554725772725416/6886584284431866807] to [installed].
2020-02-18 07:19:34,182 DEBUG [main] ProgressProgramExecutor - /app/progress/oe117/bin/_progres -pf /tmp/3987554725772725416/1202772327584922331.pf -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic -d mdy -yy 1950 -numsep 44 -numdec 46 -T /tmp -b -param /tmp/3987554725772725416/3484292492609059922.args -p /tmp/3987554725772725416/6878195307596060228/load-schema.p
2020-02-18 07:19:38,616 DEBUG [main] DatabaseSchemaProcess - Dumping sequence schema from [cusuat] to [/tmp/3987554725772725416/7413753478711930382].
2020-02-18 07:19:38,796 DEBUG [main] DatabaseSchemaProcess - Loading sequence schema from [/tmp/3987554725772725416/7413753478711930382] to [installed].
2020-02-18 07:19:38,829 DEBUG [main] ProgressProgramExecutor - /app/progress/oe117/bin/_progres -pf /tmp/3987554725772725416/4174713455578799016.pf -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic -d mdy -yy 1950 -numsep 44 -numdec 46 -T /tmp -b -param /tmp/3987554725772725416/5646381616630077139.args -p /tmp/3987554725772725416/2544249691412601566/load-schema.p
2020-02-18 07:19:38,895 DEBUG [main] DatabaseStructureActionCommand - /app/progress/oe117/bin/prostrct list /db/uat/cust/cusuat
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT - Area Name: Control Area, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 320 KByte, Name: /db/uat/cust/cusuat.db

Area Name: Primary Recovery Area, Type 3, Block Size 8192, Extents 5
   Ext # 1, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b1
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b2
   Ext # 3, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b3
   Ext # 4, Type FIXED   , Size 131072 KByte, Name: /db/uat/cust/cusuat.b4
   Ext # 5, Type VARIABLE, Size 8 KByte, Name: /db/uat/cust/cusuat.b5

Area Name: Schema Area, Type 6, Block Size 4096, Extents 2, Records/Block 32, Cluster Size 1
   Ext # 1, Type FIXED   , Size 256000 KByte, Name: /db/uat/cust/cusuat.d1
   Ext # 2, Type VARIABLE, Size 64 KByte, Name: /db/uat/cust/cusuat.d2

Area Name: INV, Type 6, Block Size 4096, Extents 7, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d1
   Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d4
   Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_7.d6
   Ext # 7, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_7.d7

Area Name: INV_IDX, Type 6, Block Size 4096, Extents 6, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d1
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_8.d5
   Ext # 6, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_8.d6

Area Name: MISC, Type 6, Block Size 4096, Extents 30, Records/Block 64, Cluster Size 64
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT -    Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d1
   Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d4
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT -    Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d6
   Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d7
   Ext # 8, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d8
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT -    Ext # 9, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d9
   Ext # 10, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d10
   Ext # 11, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d11
   Ext # 12, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d12
   Ext # 13, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d13
   Ext # 14, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d14
   Ext # 15, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d15
2020-02-18 07:19:38,909 DEBUG [Thread-5] STDOUT -    Ext # 16, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d16
   Ext # 17, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d17
   Ext # 18, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d18
   Ext # 19, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d19
   Ext # 20, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d20
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 21, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d21
   Ext # 22, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d22
   Ext # 23, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d23
   Ext # 24, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d24
   Ext # 25, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d25
   Ext # 26, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d26
   Ext # 27, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d27
   Ext # 28, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d28
   Ext # 29, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_9.d29
   Ext # 30, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_9.d30

Area Name: MISC_IDX, Type 6, Block Size 4096, Extents 12, Records/Block 64, Cluster Size 64
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d1
   Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d5
   Ext # 6, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d6
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 7, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d7
   Ext # 8, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d8
   Ext # 9, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d9
   Ext # 10, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d10
   Ext # 11, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_10.d11
   Ext # 12, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_10.d12

Area Name: ORDER, Type 6, Block Size 4096, Extents 12, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d1
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d4
   Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d6
   Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d7
   Ext # 8, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d8
   Ext # 9, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d9
   Ext # 10, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d10
   Ext # 11, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_11.d11
   Ext # 12, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_11.d12

Area Name: ORDER_IDX, Type 6, Block Size 4096, Extents 6, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d1
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_12.d5
   Ext # 6, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_12.d6
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT - 
Area Name: RGA, Type 6, Block Size 4096, Extents 12, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d1
   Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d3
   Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d4
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d6
   Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d7
   Ext # 8, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d8
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 9, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d9
   Ext # 10, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d10
   Ext # 11, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_13.d11
   Ext # 12, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_13.d12

Area Name: RGA_IDX, Type 6, Block Size 4096, Extents 10, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d1
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d4
   Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d5
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 6, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d6
   Ext # 7, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d7
   Ext # 8, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d8
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 9, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_14.d9
   Ext # 10, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_14.d10

Area Name: SHIP, Type 6, Block Size 4096, Extents 8, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d1
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d2
   Ext # 3, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d3
2020-02-18 07:19:38,910 DEBUG [Thread-5] STDOUT -    Ext # 4, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d4
   Ext # 5, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d5
   Ext # 6, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d6
2020-02-18 07:19:38,911 DEBUG [Thread-5] STDOUT -    Ext # 7, Type FIXED   , Size 512000 KByte, Name: /db/uat/cust/cusuat_15.d7
   Ext # 8, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_15.d8

Area Name: SHIP_IDX, Type 6, Block Size 4096, Extents 7, Records/Block 64, Cluster Size 64
   Ext # 1, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d1
2020-02-18 07:19:38,911 DEBUG [Thread-5] STDOUT -    Ext # 2, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d2
   Ext # 3, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d3
   Ext # 4, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d4
2020-02-18 07:19:38,911 DEBUG [Thread-5] STDOUT -    Ext # 5, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d5
   Ext # 6, Type FIXED   , Size 258048 KByte, Name: /db/uat/cust/cusuat_16.d6
   Ext # 7, Type VARIABLE, Size 256 KByte, Name: /db/uat/cust/cusuat_16.d7

2020-02-18 07:19:38,913 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/_dbutil prostrct create configured /tmp/3987554725772725416/1371927595346447894/simplified.st -blocksize 4096
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT - 
Formatting extents:
   size                area name   path name
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT -       8    Primary Recovery Area /tmp/3987554725772725416/6076747435758064451/configured.b1 00:00:00
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT -      16              Schema Area /tmp/3987554725772725416/6076747435758064451/configured.d1 00:00:00
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT -      16                      INV /tmp/3987554725772725416/6076747435758064451/configured_7.d1 00:00:00
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT -      16                  INV_IDX /tmp/3987554725772725416/6076747435758064451/configured_8.d1 00:00:00
     16                     MISC /tmp/3987554725772725416/6076747435758064451/configured_9.d1 00:00:00
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT -      16                 MISC_IDX /tmp/3987554725772725416/6076747435758064451/configured_10.d1 00:00:00
2020-02-18 07:19:38,924 DEBUG [Thread-5] STDOUT -      16                    ORDER /tmp/3987554725772725416/6076747435758064451/configured_11.d1 00:00:00
2020-02-18 07:19:38,925 DEBUG [Thread-5] STDOUT -      16                ORDER_IDX /tmp/3987554725772725416/6076747435758064451/configured_12.d1 00:00:00
2020-02-18 07:19:38,925 DEBUG [Thread-5] STDOUT -      16                      RGA /tmp/3987554725772725416/6076747435758064451/configured_13.d1 00:00:00
2020-02-18 07:19:38,925 DEBUG [Thread-5] STDOUT -      16                  RGA_IDX /tmp/3987554725772725416/6076747435758064451/configured_14.d1 00:00:00
2020-02-18 07:19:38,925 DEBUG [Thread-5] STDOUT -      16                     SHIP /tmp/3987554725772725416/6076747435758064451/configured_15.d1 00:00:00
2020-02-18 07:19:38,925 DEBUG [Thread-5] STDOUT -      16                 SHIP_IDX /tmp/3987554725772725416/6076747435758064451/configured_16.d1 00:00:00
2020-02-18 07:19:38,932 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/_dbutil procopy /app/progress/oe117/prolang/utf/empty4 configured -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:38,947 DEBUG [Thread-4] STDOUT - Procopy session begin for mfg on batch. (451)
2020-02-18 07:19:38,955 DEBUG [Thread-4] STDOUT - 
Copying /app/progress/oe117/prolang/utf/empty4 to configured... (6715)
2020-02-18 07:19:38,955 DEBUG [Thread-4] STDOUT - 
Start writing data blocks. (6718)
2020-02-18 07:19:38,957 DEBUG [Thread-4] STDOUT - 07:19:38 10 Percent complete.
2020-02-18 07:19:38,957 DEBUG [Thread-4] STDOUT - 07:19:38 20 Percent complete.
2020-02-18 07:19:38,958 DEBUG [Thread-4] STDOUT - 07:19:38 30 Percent complete.
2020-02-18 07:19:38,958 DEBUG [Thread-4] STDOUT - 07:19:38 40 Percent complete.
2020-02-18 07:19:38,959 DEBUG [Thread-4] STDOUT - 07:19:38 50 Percent complete.
2020-02-18 07:19:38,959 DEBUG [Thread-4] STDOUT - 07:19:38 60 Percent complete.
2020-02-18 07:19:38,959 DEBUG [Thread-4] STDOUT - 07:19:38 70 Percent complete.
2020-02-18 07:19:38,960 DEBUG [Thread-4] STDOUT - 07:19:38 80 Percent complete.
2020-02-18 07:19:38,960 DEBUG [Thread-4] STDOUT - 07:19:38 90 Percent complete.
2020-02-18 07:19:38,961 DEBUG [Thread-4] STDOUT - 07:19:38 100 Percent complete.
520 blocks copied. (6720)

...Copy complete. (6722)
2020-02-18 07:19:39,134 DEBUG [Thread-4] STDOUT - Database copied from /app/progress/oe117/prolang/utf/empty4. (1365)
2020-02-18 07:19:39,139 DEBUG [Thread-4] STDOUT - Procopy session end. (334)
2020-02-18 07:19:39,141 DEBUG [main] DatabaseStructureActionCommand - /app/progress/oe117/bin/prostrct list /tmp/3987554725772725416/6076747435758064451/configured
2020-02-18 07:19:39,157 DEBUG [Thread-4] STDOUT - Area Name: Control Area, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 32 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured.db

Area Name: Primary Recovery Area, Type 3, Block Size 8192, Extents 1
   Ext # 1, Type VARIABLE, Size 2176 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured.b1
2020-02-18 07:19:39,157 DEBUG [Thread-4] STDOUT - 
Area Name: Schema Area, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 2112 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured.d1

Area Name: INV, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_7.d1

Area Name: INV_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_8.d1

Area Name: MISC, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_9.d1

Area Name: MISC_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_10.d1

Area Name: ORDER, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_11.d1

Area Name: ORDER_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_12.d1

Area Name: RGA, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_13.d1

Area Name: RGA_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_14.d1

Area Name: SHIP, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_15.d1

2020-02-18 07:19:39,158 DEBUG [Thread-4] STDOUT - Area Name: SHIP_IDX, Type 6, Block Size 4096, Extents 1, Records/Block 32, Cluster Size 1
   Ext # 1, Type VARIABLE, Size 64 KByte, Name: /tmp/3987554725772725416/6076747435758064451/configured_16.d1

2020-02-18 07:19:39,159 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/proutil /tmp/3987554725772725416/6076747435758064451/configured -C truncate bi -biblocksize 8 -bi 512 -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:39,162 DEBUG [Thread-4] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:19:39,182 DEBUG [Thread-4] STDOUT - Before-image cluster size set to 512 kb. (1620)
Before-image block size set to 8 kb (8192 bytes). (3781)
2020-02-18 07:19:39,190 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/_rfutil /tmp/3987554725772725416/6076747435758064451/configured -C aimage truncate -aiblocksize 8 -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:39,311 DEBUG [Thread-5] STDOUT - The AI file is being truncated. (287)
After-image block size set to 8 kb (8192 bytes). (644)
2020-02-18 07:19:39,312 DEBUG [Thread-5] STDOUT - Truncation complete. (292)
2020-02-18 07:19:39,316 DEBUG [main] DatabaseCreateCommand - /app/progress/oe117/bin/proutil /tmp/3987554725772725416/6076747435758064451/configured -C EnableLargeFiles -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic
2020-02-18 07:19:39,320 DEBUG [Thread-5] STDOUT - OpenEdge Release 11.7.3 as of Fri Apr 27 16:18:52 EDT 2018
2020-02-18 07:19:39,336 DEBUG [Thread-5] STDOUT - Large database file access enabled for database /tmp/3987554725772725416/6076747435758064451/configured. (9425)
2020-02-18 07:19:39,337 DEBUG [main] DatabaseSchemaProcess - Applying schema.customization-custom to [configured].
2020-02-18 07:19:39,365 DEBUG [main] ProgressProgramExecutor - /app/progress/oe117/bin/_progres -pf /tmp/3987554725772725416/6407122436101862984.pf -cpstream utf-8 -cpinternal utf-8 -cpcoll ICU-UCA -cpcase basic -d mdy -yy 1950 -numsep 44 -numdec 46 -T /tmp -b -param /tmp/3987554725772725416/2650441933797798323.args -p /tmp/3987554725772725416/7963089836400247245/load-schema.p
2020-02-18 07:19:39,421 ERROR [main] OpenEdgeDatabaseSchemaLoadCommand - 

The following errors and/or warnings occurred while loading /app/qad/uat/customizations/schema/custom/CR8735-1-Triggers.df
into database configured on 02/18/20 at 07:19.


** Error during MODIFY TABLE xart_det **

** Line 1 UPDATE TABLE xart_det

Try to modify unknown TABLE


** Error during DELETE ? ? **

** Line 2 DELETE

Unknown object


** Error during DELETE ? ? **

** Line 3 DELETE

Unknown object


** Error during MODIFY TABLE xfcstd_det **

** Line 5 UPDATE TABLE xfcstd_det

Try to modify unknown TABLE


** Error during DELETE ? ? **

** Line 6 DELETE

Unknown object


** Error during MODIFY TABLE xpt_mstr **

** Line 8 UPDATE TABLE xpt_mstr

Try to modify unknown TABLE


** Error during DELETE ? ? **

** Line 9 DELETE

Unknown object


** Error during MODIFY TABLE xtod_det **

** Line 11 UPDATE TABLE xtod_det

Try to modify unknown TABLE


** Error during DELETE ? ? **

** Line 12 DELETE

Unknown object


** Error during MODIFY TABLE xvd_mstr **

** Line 14 UPDATE TABLE xvd_mstr

Try to modify unknown TABLE

02/18/20 07:19 : Load of /app/qad/uat/customizations/schema/custom/CR8735-1-Triggers.df into database configured was unsuccessful.
 All the changes were backed out...
 OpenEdge error(s)
 Usr  set name to . (7129)


2020-02-18 07:19:39,427 DEBUG [main] BuildContext - database-custom-schema-update ERROR
2020-02-18 07:19:39,473 ERROR [main] Main - BUILD FAILED (2:00 m)
java.lang.RuntimeException: Errors occurred loading schema file [/app/qad/uat/customizations/schema/custom/CR8735-1-Triggers.df].
    at com.qad.build.progress.tasks.database.OpenEdgeDatabaseSchemaLoadCommand.invoke(OpenEdgeDatabaseSchemaLoadCommand.java:101)
    at com.qad.yab.database.DatabaseSchemaProcess.createDatabaseLike(DatabaseSchemaProcess.java:666)
    at com.qad.yab.database.DatabaseSchemaProcess.execute(DatabaseSchemaProcess.java:395)
    at com.qad.yab.impl.BuildContext$ProcessExecutor.execute(BuildContext.java:1232)
    at com.qad.yab.impl.BuildContext$6.handleProcess(BuildContext.java:1078)
    at com.qad.yab.impl.ProcessWhiteboard$ProcessVisitor.dispatchSerial(ProcessWhiteboard.java:1075)
    at com.qad.yab.impl.ProcessWhiteboard$ProcessVisitor.dispatch(ProcessWhiteboard.java:1044)
    at com.qad.yab.impl.BuildContext.service(BuildContext.java:1070)
    at com.qad.yab.impl.BuildContext.service(BuildContext.java:911)
    at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
    at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
    at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
    at java.lang.reflect.Method.invoke(Method.java:498)
    at com.qad.yab.loader.Build.invoke(Build.java:231)
    at com.qad.yab.loader.Build.service(Build.java:106)
    at com.qad.yab.loader.Main.mainNoExit(Main.java:568)
    at com.qad.yab.loader.Main.main(Main.java:94)
2020-02-18 07:19:39,484 INFO  [main] Main - END
 

 

00
Replied: Feb 18, 2020
Votes
Will Buttitta
Will
 20
Replied 

It would be really nice if we had an attachment feature on this forum :)

The problem is that we are loading the two DF files in the wrong order as hinted at by this log message:

2020-02-18 07:19:32,439 DEBUG [main] DatabaseSchemaProcess - Schema Files [/app/qad/uat/customizations/schema/custom/CR8735-1-Triggers.df, /app/qad/uat/customizations/schema/custom/custom.df].

Earlier I said this...

The simplest model and the one we recommend is that you would have a single DF file that represents the schema you desire but if there is a compelling reason to distribute the schema across multiple files you can put all the files in that directory and we will automatically figure out the dependency order in which they should be loaded from YAB 1.6 on (in other words this setting "schema.customization-custom.direct=true" is ignored from 1.6 on).

Based on your outcome I looked up the ticket where we introduced support for automatically discovering the dependency ordering of DF files and that was not introduced until YAB 1.8, so my statement above needs to be amended.

Since you are on 1.6 (and I assume you want to keep the two DF files separate) we need two distinct schema configurations. One way to set this up is to define two directories, one for "full" schema files and the other for "incremental" schema files and then copy the "custom.df" into the full and the trigger file into the incremental directory, configured like this...

schema.customization-custom-full.dir=<QADHOME>/customizations/schema/custom/full
schema.customization-custom-full.database=db.custom

schema.customization-custom-incremental.dir=<QADHOME>/customizations/schema/custom/incremental
schema.customization-custom-incremental.database=db.custom
schema.customization-custom-incremental.incremental=true

 

00
Replied: Feb 18, 2020
Votes
Lenard McMinn
Lenard
 0
Replied 

If I go down this path and create an incremental dir, will I be able to place incremental files in the incremental dir and prcoesss them?  Or will I only be able to place one incrmental in the incremental dir and have to create a new dir every time I want to load another incremental?  I don't mean to be difficult.  Yet I really need to understand how this is meant to work.  We envision developers submitting their own incremental file each and every time a solution requires a change.  And we mean to source code control these.df artifacts.  We don't to use the same file name over and over again.

Should we be looking at the full custom.df as the artifact and version control a single file?  A kind of, "here is what my database schema is today" each time it is submitted?"

...starting to wish I had QAD support on the phone

00
Replied: Feb 18, 2020
Votes
Will Buttitta
Will
 20
Replied 

To answer your first question, you could continually add files into the incremental dir without requiring any more configuration changes, but this is definitely the hard way to skin this problem.

If I understand what you want to do, then I would have a single DF file under revision control (e.g. "custom.df") and this file would reflect the schema you want. Of course, you may branch your code under revision control, but to keep the discussion straight forward imagine a main line of development (e.g. "head" or "trunk") with a sequence of revisions. A developer that is on rev 5 of the schema for example that pulls an update to get this file to rev 8 would get the incremental difference between 5 and 8 applied to their environment when the schema is applied in their environment.

...starting to wish I had QAD support on the phone

Feel free to get that started. If you think getting the YAB development team involved would help have them loop us in.

 

00
Replied: Feb 18, 2020
Forums
All
Forum Help
Help Using Forums