02 Jun 2021 02:01:41,388 INFO : Starting to run task 'org.labkey.study.pipeline.StudyReloadSourceTask' at location 'webserver'

02 Jun 2021 02:01:41,389 INFO : Starting REDCap export

02 Jun 2021 02:01:42,340 INFO : Creating study archive

02 Jun 2021 02:01:42,341 INFO : Writing dataset metadata

02 Jun 2021 02:01:42,454 INFO : Creating column lookups

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,692 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,693 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,694 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,694 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,694 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,694 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,694 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,694 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,695 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,696 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,697 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,698 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,698 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,698 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,700 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,701 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,701 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,702 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

02 Jun 2021 02:01:44,704 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,705 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,706 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,707 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

02 Jun 2021 02:01:44,709 INFO : Finished creating study archive

02 Jun 2021 02:01:44,709 INFO : Successfully completed task 'org.labkey.study.pipeline.StudyReloadSourceTask'

02 Jun 2021 02:01:44,789 INFO : Starting to run task 'org.labkey.study.importer.StudyImportInitialTask' at location 'webserver'

02 Jun 2021 02:01:44,792 INFO : Reloading study from study.xml

02 Jun 2021 02:01:44,797 INFO : Loading top-level study properties (label, start/end date, description, etc.)

02 Jun 2021 02:01:45,233 INFO : Done importing top-level study properties (label, start/end date, description, etc.)

02 Jun 2021 02:01:45,252 INFO : Loading datasets manifest from datasets_manifest.xml

02 Jun 2021 02:01:45,255 INFO : Loading dataset schema from datasets_metadata.xml

02 Jun 2021 02:01:46,322 INFO : Successfully completed task 'org.labkey.study.importer.StudyImportInitialTask'

02 Jun 2021 02:01:46,372 INFO : Starting to run task 'org.labkey.study.pipeline.StudyImportDatasetTask' at location 'webserver'

02 Jun 2021 02:01:46,373 INFO : Start batch RedCap Integration.dataset

02 Jun 2021 02:01:46,425 INFO : demographics: Starting import from dataset001.tsv

02 Jun 2021 02:01:46,833 INFO : demographics: Processed 5 rows from dataset001.tsv

02 Jun 2021 02:01:46,833 INFO : demographics: Deleted 5 rows

02 Jun 2021 02:01:46,833 INFO : demographics: Merged 5 rows

02 Jun 2021 02:01:46,871 INFO : emergency_contact_info: Starting import from dataset002.tsv

02 Jun 2021 02:01:47,180 INFO : emergency_contact_info: Processed 5 rows from dataset002.tsv

02 Jun 2021 02:01:47,180 INFO : emergency_contact_info: Deleted 5 rows

02 Jun 2021 02:01:47,180 INFO : emergency_contact_info: Merged 5 rows

02 Jun 2021 02:01:47,219 INFO : baseline_lab_data: Starting import from dataset003.tsv

02 Jun 2021 02:01:47,541 INFO : baseline_lab_data: Processed 5 rows from dataset003.tsv

02 Jun 2021 02:01:47,541 INFO : baseline_lab_data: Deleted 5 rows

02 Jun 2021 02:01:47,541 INFO : baseline_lab_data: Merged 5 rows

02 Jun 2021 02:01:47,579 INFO : visit_blood_workup: Starting import from dataset004.tsv

02 Jun 2021 02:01:47,678 INFO : completion_data: Starting import from dataset005.tsv

02 Jun 2021 02:01:47,773 INFO : completion_project_questionnaire: Starting import from dataset006.tsv

02 Jun 2021 02:01:47,867 INFO : Finish batch RedCap Integration.dataset

02 Jun 2021 02:01:47,872 INFO : Updating participant visits

02 Jun 2021 02:01:47,873 INFO : Updating participants

02 Jun 2021 02:01:47,879 INFO : Updating participant visit table

02 Jun 2021 02:01:47,941 INFO : Updating visit table

02 Jun 2021 02:01:47,945 INFO : Updating cohorts

02 Jun 2021 02:01:47,945 INFO : Clearing participant visit caches

02 Jun 2021 02:01:47,947 INFO : Finished updating participants

02 Jun 2021 02:01:47,952 INFO : Successfully completed task 'org.labkey.study.pipeline.StudyImportDatasetTask'

02 Jun 2021 02:01:47,996 INFO : Starting to run task 'org.labkey.api.specimen.pipeline.StudyImportSpecimenTask' at location 'webserver'

02 Jun 2021 02:01:47,997 INFO : Successfully completed task 'org.labkey.api.specimen.pipeline.StudyImportSpecimenTask'

02 Jun 2021 02:01:48,050 INFO : Starting to run task 'org.labkey.study.importer.StudyImportFinalTask' at location 'webserver'

02 Jun 2021 02:01:48,080 INFO : Loading dataset cohort assignments

02 Jun 2021 02:01:48,080 INFO : Done importing dataset cohort assignments

02 Jun 2021 02:01:48,108 INFO : Loading lists

02 Jun 2021 02:01:48,114 INFO : Truncating list: vbw8

02 Jun 2021 02:26:09,337 INFO : Recreating list: vbw8

02 Jun 2021 02:26:09,591 INFO : Truncating list: cpq13

02 Jun 2021 02:26:09,829 INFO : Recreating list: cpq13

02 Jun 2021 02:26:09,978 INFO : Truncating list: sex

02 Jun 2021 02:26:10,137 INFO : Recreating list: sex

02 Jun 2021 02:26:10,250 INFO : Truncating list: withdraw_reason

02 Jun 2021 02:26:10,365 INFO : Recreating list: withdraw_reason

02 Jun 2021 02:26:10,492 INFO : Truncating list: cpq6

02 Jun 2021 02:26:10,618 INFO : Recreating list: cpq6

02 Jun 2021 02:26:10,751 INFO : Truncating list: vbw9

02 Jun 2021 02:26:10,913 INFO : Recreating list: vbw9

02 Jun 2021 02:26:11,035 INFO : Truncating list: cpq8

02 Jun 2021 02:26:11,142 INFO : Recreating list: cpq8

02 Jun 2021 02:26:11,291 INFO : Truncating list: cpq10

02 Jun 2021 02:26:11,418 INFO : Recreating list: cpq10

02 Jun 2021 02:26:11,527 INFO : Truncating list: vbw6

02 Jun 2021 02:26:11,644 INFO : Recreating list: vbw6

02 Jun 2021 02:26:11,813 INFO : Truncating list: cpq11

02 Jun 2021 02:26:11,987 INFO : Recreating list: cpq11

02 Jun 2021 02:26:12,097 INFO : Truncating list: vbw7

02 Jun 2021 02:26:12,198 INFO : Recreating list: vbw7

02 Jun 2021 02:26:12,414 INFO : Merged 5 row(s) into list: withdraw_reason

02 Jun 2021 02:26:12,469 INFO : Merged 3 row(s) into list: cpq13

02 Jun 2021 02:26:12,528 INFO : Merged 6 row(s) into list: cpq11

02 Jun 2021 02:26:12,594 INFO : Merged 4 row(s) into list: cpq10

02 Jun 2021 02:26:12,657 INFO : Merged 2 row(s) into list: sex

02 Jun 2021 02:26:12,705 INFO : Merged 2 row(s) into list: vbw9

02 Jun 2021 02:26:12,769 INFO : Merged 3 row(s) into list: cpq8

02 Jun 2021 02:26:12,820 INFO : Merged 3 row(s) into list: vbw8

02 Jun 2021 02:26:12,881 INFO : Merged 4 row(s) into list: vbw7

02 Jun 2021 02:26:12,964 INFO : Merged 5 row(s) into list: cpq6

02 Jun 2021 02:26:13,017 INFO : Merged 2 row(s) into list: vbw6

02 Jun 2021 02:26:13,020 INFO : 11 lists imported successfully

02 Jun 2021 02:26:13,020 INFO : Done importing lists

02 Jun 2021 02:26:13,038 INFO : Post-processing queries

02 Jun 2021 02:26:13,038 INFO : Skipping query validation.

02 Jun 2021 02:26:13,038 INFO : Done post-processing queries

02 Jun 2021 02:26:13,050 INFO : Successfully completed task 'org.labkey.study.importer.StudyImportFinalTask'