09 Jun 2021 02:56:24,822 INFO : Starting to run task 'org.labkey.study.pipeline.StudyReloadSourceTask' at location 'webserver'

09 Jun 2021 02:56:24,835 INFO : Starting REDCap export

09 Jun 2021 02:56:26,025 INFO : Creating study archive

09 Jun 2021 02:56:26,050 INFO : Writing dataset metadata

09 Jun 2021 02:56:26,200 INFO : Creating column lookups

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: demographics row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,066 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: emergency_contact_info row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: baseline_lab_data row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,067 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: visit_blood_workup row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_data row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,068 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,069 WARN : Unable to locate subject id field: first_name for dataset: completion_project_questionnaire row ignored.

09 Jun 2021 02:56:27,071 INFO : Finished creating study archive

09 Jun 2021 02:56:27,071 INFO : Successfully completed task 'org.labkey.study.pipeline.StudyReloadSourceTask'

09 Jun 2021 02:56:27,133 INFO : Starting to run task 'org.labkey.study.importer.StudyImportInitialTask' at location 'webserver'

09 Jun 2021 02:56:27,138 INFO : Reloading study from study.xml

09 Jun 2021 02:56:27,153 INFO : Loading top-level study properties (label, start/end date, description, etc.)

09 Jun 2021 02:56:27,897 INFO : Done importing top-level study properties (label, start/end date, description, etc.)

09 Jun 2021 02:56:27,926 INFO : Loading datasets manifest from datasets_manifest.xml

09 Jun 2021 02:56:27,930 INFO : Loading dataset schema from datasets_metadata.xml

09 Jun 2021 02:56:28,798 INFO : Successfully completed task 'org.labkey.study.importer.StudyImportInitialTask'

09 Jun 2021 02:56:28,836 INFO : Starting to run task 'org.labkey.study.pipeline.StudyImportDatasetTask' at location 'webserver'

09 Jun 2021 02:56:28,843 INFO : Start batch RedCap Integration.dataset

09 Jun 2021 02:56:28,887 INFO : demographics: Starting import from dataset001.tsv

09 Jun 2021 02:56:30,723 INFO : demographics: Processed 5 rows from dataset001.tsv

09 Jun 2021 02:56:30,723 INFO : demographics: Deleted 5 rows

09 Jun 2021 02:56:30,723 INFO : demographics: Merged 5 rows

09 Jun 2021 02:56:30,757 INFO : emergency_contact_info: Starting import from dataset002.tsv

09 Jun 2021 02:56:31,760 INFO : emergency_contact_info: Processed 5 rows from dataset002.tsv

09 Jun 2021 02:56:31,760 INFO : emergency_contact_info: Deleted 5 rows

09 Jun 2021 02:56:31,760 INFO : emergency_contact_info: Merged 5 rows

09 Jun 2021 02:56:31,792 INFO : baseline_lab_data: Starting import from dataset003.tsv

09 Jun 2021 02:56:32,284 INFO : baseline_lab_data: Processed 5 rows from dataset003.tsv

09 Jun 2021 02:56:32,284 INFO : baseline_lab_data: Deleted 5 rows

09 Jun 2021 02:56:32,285 INFO : baseline_lab_data: Merged 5 rows

09 Jun 2021 02:56:32,311 INFO : visit_blood_workup: Starting import from dataset004.tsv

09 Jun 2021 02:56:32,389 INFO : completion_data: Starting import from dataset005.tsv

09 Jun 2021 02:56:32,456 INFO : completion_project_questionnaire: Starting import from dataset006.tsv

09 Jun 2021 02:56:32,524 INFO : Finish batch RedCap Integration.dataset

09 Jun 2021 02:56:32,528 INFO : Updating participant visits

09 Jun 2021 02:56:32,528 INFO : Updating participants

09 Jun 2021 02:56:32,532 INFO : Updating participant visit table

09 Jun 2021 02:56:32,602 INFO : Updating visit table

09 Jun 2021 02:56:32,605 INFO : Updating cohorts

09 Jun 2021 02:56:32,605 INFO : Clearing participant visit caches

09 Jun 2021 02:56:32,607 INFO : Finished updating participants

09 Jun 2021 02:56:32,613 INFO : Successfully completed task 'org.labkey.study.pipeline.StudyImportDatasetTask'

09 Jun 2021 02:56:32,665 INFO : Starting to run task 'org.labkey.api.specimen.pipeline.StudyImportSpecimenTask' at location 'webserver'

09 Jun 2021 02:56:32,667 INFO : Successfully completed task 'org.labkey.api.specimen.pipeline.StudyImportSpecimenTask'

09 Jun 2021 02:56:32,718 INFO : Starting to run task 'org.labkey.study.importer.StudyImportFinalTask' at location 'webserver'

09 Jun 2021 02:56:32,748 INFO : Loading dataset cohort assignments

09 Jun 2021 02:56:32,749 INFO : Done importing dataset cohort assignments

09 Jun 2021 02:56:32,791 INFO : Loading lists

09 Jun 2021 02:56:32,802 INFO : Truncating list: vbw8

09 Jun 2021 02:56:33,238 INFO : Recreating list: vbw8

09 Jun 2021 02:56:33,458 INFO : Truncating list: cpq13

09 Jun 2021 02:56:33,610 INFO : Recreating list: cpq13

09 Jun 2021 02:56:33,840 INFO : Truncating list: sex

09 Jun 2021 02:56:33,963 INFO : Recreating list: sex

09 Jun 2021 02:56:34,055 INFO : Truncating list: withdraw_reason

09 Jun 2021 02:56:34,227 INFO : Recreating list: withdraw_reason

09 Jun 2021 02:56:34,351 INFO : Truncating list: cpq6

09 Jun 2021 02:56:34,464 INFO : Recreating list: cpq6

09 Jun 2021 02:56:34,573 INFO : Truncating list: vbw9

09 Jun 2021 02:56:34,699 INFO : Recreating list: vbw9

09 Jun 2021 02:56:34,788 INFO : Truncating list: cpq8

09 Jun 2021 02:56:34,917 INFO : Recreating list: cpq8

09 Jun 2021 02:56:35,021 INFO : Truncating list: cpq10

09 Jun 2021 02:56:35,158 INFO : Recreating list: cpq10

09 Jun 2021 02:56:35,471 INFO : Truncating list: vbw6

09 Jun 2021 02:56:35,576 INFO : Recreating list: vbw6

09 Jun 2021 02:56:35,665 INFO : Truncating list: cpq11

09 Jun 2021 02:56:35,756 INFO : Recreating list: cpq11

09 Jun 2021 02:56:35,857 INFO : Truncating list: vbw7

09 Jun 2021 02:56:35,957 INFO : Recreating list: vbw7

09 Jun 2021 02:56:36,099 INFO : Merged 5 row(s) into list: withdraw_reason

09 Jun 2021 02:56:36,142 INFO : Merged 3 row(s) into list: cpq13

09 Jun 2021 02:56:36,184 INFO : Merged 6 row(s) into list: cpq11

09 Jun 2021 02:56:36,225 INFO : Merged 4 row(s) into list: cpq10

09 Jun 2021 02:56:36,267 INFO : Merged 2 row(s) into list: sex

09 Jun 2021 02:56:36,306 INFO : Merged 2 row(s) into list: vbw9

09 Jun 2021 02:56:36,347 INFO : Merged 3 row(s) into list: vbw8

09 Jun 2021 02:56:36,389 INFO : Merged 3 row(s) into list: cpq8

09 Jun 2021 02:56:36,430 INFO : Merged 4 row(s) into list: vbw7

09 Jun 2021 02:56:36,470 INFO : Merged 2 row(s) into list: vbw6

09 Jun 2021 02:56:36,509 INFO : Merged 5 row(s) into list: cpq6

09 Jun 2021 02:56:36,513 INFO : 11 lists imported successfully

09 Jun 2021 02:56:36,513 INFO : Done importing lists

09 Jun 2021 02:56:36,516 INFO : Post-processing queries

09 Jun 2021 02:56:36,516 INFO : Skipping query validation.

09 Jun 2021 02:56:36,516 INFO : Done post-processing queries

09 Jun 2021 02:56:36,527 INFO : Successfully completed task 'org.labkey.study.importer.StudyImportFinalTask'