19 May 2021 02:02:36,984 INFO : Starting to run task 'org.labkey.study.pipeline.StudyReloadSourceTask' at location 'webserver'

19 May 2021 02:02:36,985 INFO : Starting REDCap export

19 May 2021 02:02:37,894 INFO : Creating study archive

19 May 2021 02:02:37,896 INFO : Writing dataset metadata

19 May 2021 02:02:37,946 INFO : Creating column lookups

19 May 2021 02:02:38,673 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,674 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,675 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,676 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,677 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,678 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,679 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

19 May 2021 02:02:38,681 INFO : Finished creating study archive

19 May 2021 02:02:38,681 INFO : Successfully completed task 'org.labkey.study.pipeline.StudyReloadSourceTask'

19 May 2021 02:02:38,712 INFO : Starting to run task 'org.labkey.study.importer.StudyImportInitialTask' at location 'webserver'

19 May 2021 02:02:38,714 INFO : Reloading study from study.xml

19 May 2021 02:02:38,718 INFO : Loading top-level study properties (label, start/end date, description, etc.)

19 May 2021 02:02:39,326 INFO : Done importing top-level study properties (label, start/end date, description, etc.)

19 May 2021 02:02:39,344 INFO : Loading datasets manifest from datasets_manifest.xml

19 May 2021 02:02:39,346 INFO : Loading dataset schema from datasets_metadata.xml

19 May 2021 02:02:40,449 INFO : Successfully completed task 'org.labkey.study.importer.StudyImportInitialTask'

19 May 2021 02:02:40,474 INFO : Starting to run task 'org.labkey.study.pipeline.StudyImportDatasetTask' at location 'webserver'

19 May 2021 02:02:40,475 INFO : Start batch RedCap Integration.dataset

19 May 2021 02:02:40,525 INFO : demographics: Starting import from dataset001.tsv

19 May 2021 02:02:40,855 INFO : demographics: Processed 5 rows from dataset001.tsv

19 May 2021 02:02:40,855 INFO : demographics: Deleted 5 rows

19 May 2021 02:02:40,855 INFO : demographics: Merged 5 rows

19 May 2021 02:02:40,875 INFO : emergency_contact_info: Starting import from dataset002.tsv

19 May 2021 02:02:41,158 INFO : emergency_contact_info: Processed 5 rows from dataset002.tsv

19 May 2021 02:02:41,158 INFO : emergency_contact_info: Deleted 5 rows

19 May 2021 02:02:41,158 INFO : emergency_contact_info: Merged 5 rows

19 May 2021 02:02:41,183 INFO : baseline_lab_data: Starting import from dataset003.tsv

19 May 2021 02:02:41,420 INFO : baseline_lab_data: Processed 5 rows from dataset003.tsv

19 May 2021 02:02:41,420 INFO : baseline_lab_data: Deleted 5 rows

19 May 2021 02:02:41,420 INFO : baseline_lab_data: Merged 5 rows

19 May 2021 02:02:41,442 INFO : visit_blood_workup: Starting import from dataset004.tsv

19 May 2021 02:02:41,526 INFO : completion_data: Starting import from dataset005.tsv

19 May 2021 02:02:41,584 INFO : completion_project_questionnaire: Starting import from dataset006.tsv

19 May 2021 02:02:41,644 INFO : Finish batch RedCap Integration.dataset

19 May 2021 02:02:41,647 INFO : Updating participant visits

19 May 2021 02:02:41,647 INFO : Updating participants

19 May 2021 02:02:41,652 INFO : Updating participant visit table

19 May 2021 02:02:41,709 INFO : Updating visit table

19 May 2021 02:02:41,713 INFO : Updating cohorts

19 May 2021 02:02:41,713 INFO : Clearing participant visit caches

19 May 2021 02:02:41,715 INFO : Finished updating participants

19 May 2021 02:02:41,716 INFO : Successfully completed task 'org.labkey.study.pipeline.StudyImportDatasetTask'

19 May 2021 02:02:41,748 INFO : Starting to run task 'org.labkey.api.specimen.pipeline.StudyImportSpecimenTask' at location 'webserver'

19 May 2021 02:02:41,748 INFO : Successfully completed task 'org.labkey.api.specimen.pipeline.StudyImportSpecimenTask'

19 May 2021 02:02:41,773 INFO : Starting to run task 'org.labkey.study.importer.StudyImportFinalTask' at location 'webserver'

19 May 2021 02:02:41,792 INFO : Loading dataset cohort assignments

19 May 2021 02:02:41,793 INFO : Done importing dataset cohort assignments

19 May 2021 02:02:41,827 INFO : Loading lists

19 May 2021 02:02:41,830 INFO : Truncating list: vbw8

19 May 2021 02:24:42,106 INFO : Recreating list: vbw8

19 May 2021 02:24:42,402 INFO : Truncating list: cpq13

19 May 2021 02:24:42,600 INFO : Recreating list: cpq13

19 May 2021 02:24:42,825 INFO : Truncating list: sex

19 May 2021 02:24:42,966 INFO : Recreating list: sex

19 May 2021 02:24:43,075 INFO : Truncating list: withdraw_reason

19 May 2021 02:24:43,171 INFO : Recreating list: withdraw_reason

19 May 2021 02:24:43,263 INFO : Truncating list: cpq6

19 May 2021 02:24:43,367 INFO : Recreating list: cpq6

19 May 2021 02:24:43,491 INFO : Truncating list: vbw9

19 May 2021 02:24:43,589 INFO : Recreating list: vbw9

19 May 2021 02:24:43,688 INFO : Truncating list: cpq8

19 May 2021 02:24:43,792 INFO : Recreating list: cpq8

19 May 2021 02:24:43,880 INFO : Truncating list: cpq10

19 May 2021 02:24:43,984 INFO : Recreating list: cpq10

19 May 2021 02:24:44,093 INFO : Truncating list: vbw6

19 May 2021 02:24:44,192 INFO : Recreating list: vbw6

19 May 2021 02:24:44,300 INFO : Truncating list: cpq11

19 May 2021 02:24:44,411 INFO : Recreating list: cpq11

19 May 2021 02:24:44,538 INFO : Truncating list: vbw7

19 May 2021 02:24:44,652 INFO : Recreating list: vbw7

19 May 2021 02:24:47,795 INFO : Merged 5 row(s) into list: withdraw_reason

19 May 2021 02:24:47,866 INFO : Merged 3 row(s) into list: cpq13

19 May 2021 02:24:47,946 INFO : Merged 6 row(s) into list: cpq11

19 May 2021 02:24:48,014 INFO : Merged 4 row(s) into list: cpq10

19 May 2021 02:24:48,085 INFO : Merged 2 row(s) into list: sex

19 May 2021 02:24:48,146 INFO : Merged 2 row(s) into list: vbw9

19 May 2021 02:24:48,209 INFO : Merged 3 row(s) into list: vbw8

19 May 2021 02:24:48,282 INFO : Merged 3 row(s) into list: cpq8

19 May 2021 02:24:48,340 INFO : Merged 4 row(s) into list: vbw7

19 May 2021 02:24:48,400 INFO : Merged 5 row(s) into list: cpq6

19 May 2021 02:24:48,461 INFO : Merged 2 row(s) into list: vbw6

19 May 2021 02:24:48,464 INFO : 11 lists imported successfully

19 May 2021 02:24:48,464 INFO : Done importing lists

19 May 2021 02:24:48,479 INFO : Post-processing queries

19 May 2021 02:24:48,479 INFO : Skipping query validation.

19 May 2021 02:24:48,479 INFO : Done post-processing queries

19 May 2021 02:24:48,495 INFO : Successfully completed task 'org.labkey.study.importer.StudyImportFinalTask'