search

uwrit / leaf

Leaf Clinical Data Explorer
https://www.youtube.com/watch?v=ZuKKC7B8mHI
Other
88 stars 47 forks source link

"Not Patients Who" fails #472

Open artgoldberg opened 2 years ago

artgoldberg commented 2 years ago

Hi Folks

We see repeatable failures with "Not Patients Who" queries. E.g., "Not Patents Who ... Identify as MALE". The corresponding non-negated queries run. Happens in multiple domains. The logs don't make sense. No SqlStatement entry appears.

Exception handled by line 73 in leaf/src/server/API/Controllers/CohortCountController.cs. It says System.InvalidOperationException: Sequence contains no elements .... Will also fail Error Will fail

See screenshots and a complete log (with new-lines fixed).

{"Timestamp":"2021-10-27T15:18:33.9663131-04:00","Level":"Information","MessageTemplate":"Refreshed TokenBlacklistCache","Properties":{"SourceContext":"API.Jobs.BackgroundTokenBlacklistSynchronizer"}}
{"Timestamp":"2021-10-27T15:19:03.4011339-04:00","Level":"Information","MessageTemplate":"{HostingRequestStartingLog:l}","Properties":{"Protocol":"HTTP/1.1","Method":"POST","ContentType":"application/json;charset=UTF-8","ContentLength":1784,"Scheme":"http","Host":"10.95.46.180:5001","PathBase":"","Path":"/api/cohort/count","QueryString":"","HostingRequestStartingLog":"Request starting HTTP/1.1 POST http://10.95.46.180:5001/api/cohort/count application/json;charset=UTF-8 1784","EventId":{"Id":1},"SourceContext":"Microsoft.AspNetCore.Hosting.Diagnostics","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K"},"Renderings":{"HostingRequestStartingLog":[{"Format":"l","Rendering":"Request starting HTTP/1.1 POST http://10.95.46.180:5001/api/cohort/count application/json;charset=UTF-8 1784"}]}}
{"Timestamp":"2021-10-27T15:19:03.4014135-04:00","Level":"Information","MessageTemplate":"CORS policy execution successful.","Properties":{"EventId":{"Id":4,"Name":"PolicySuccess"},"SourceContext":"Microsoft.AspNetCore.Cors.Infrastructure.CorsService","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K"}}
{"Timestamp":"2021-10-27T15:19:03.4021635-04:00","Level":"Information","MessageTemplate":"Successfully validated the token.","Properties":{"EventId":{"Id":2,"Name":"TokenValidationSucceeded"},"SourceContext":"Microsoft.AspNetCore.Authentication.JwtBearer.JwtBearerHandler","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K"}}
{"Timestamp":"2021-10-27T15:19:03.4024439-04:00","Level":"Information","MessageTemplate":"Route matched with {RouteData}. Executing controller action with signature {MethodInfo} on controller {Controller} ({AssemblyName}).","Properties":{"RouteData":"{action = \"Count\", controller = \"CohortCount\"}","MethodInfo":"System.Threading.Tasks.Task`1[Microsoft.AspNetCore.Mvc.ActionResult`1[API.DTO.Cohort.CohortCountDTO]] Count(API.DTO.Cohort.PatientCountQueryDTO, Model.Cohort.CohortCounter, System.Threading.CancellationToken)","Controller":"API.Controllers.CohortCountController","AssemblyName":"API","EventId":{"Id":3,"Name":"ControllerActionExecuting"},"SourceContext":"Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4026323-04:00","Level":"Information","MessageTemplate":"Authorization was successful.","Properties":{"EventId":{"Id":1,"Name":"UserAuthorizationSucceeded"},"SourceContext":"Microsoft.AspNetCore.Authorization.DefaultAuthorizationService","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4036123-04:00","Level":"Information","MessageTemplate":"FullCount starting. DTO:{@DTO}","Properties":{"DTO":{"_typeTag":"PatientCountQueryDTO","QueryId":"","Panels":[{"_typeTag":"PanelDTO","Id":"kcwVfwlfm9C","SubPanels":[{"_typeTag":"SubPanelDTO","Id":"9lf3OrInulE","PanelItems":[{"_typeTag":"PanelItemDTO","Id":"wa5-Y7EIb","Resource":{"_typeTag":"ResourceRef","Id":"ddfb3d76-c632-ec11-9c22-000c29db1cc8","UniversalId":null,"UiDisplayName":"Mobile Unit"},"Specializations":[],"NumericFilter":{"_typeTag":"NumericFilter","FilterType":"None","Filter":[]},"RecencyFilter":"None","Index":0,"SubPanelIndex":0,"PanelIndex":0}],"PanelIndex":0,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}},{"_typeTag":"SubPanelDTO","Id":"kOx4_eQpPi","PanelItems":[],"PanelIndex":0,"Index":1,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":false,"Domain":"Panel","Index":0},{"_typeTag":"PanelDTO","Id":"MAnTZydfLKU","SubPanels":[{"_typeTag":"SubPanelDTO","Id":"ysuCNTNjL-p","PanelItems":[],"PanelIndex":1,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":true,"Domain":"Panel","Index":1},{"_typeTag":"PanelDTO","Id":"dgTzjOMJA2f","SubPanels":[{"_typeTag":"SubPanelDTO","Id":"EsbBbGu-cpc","PanelItems":[],"PanelIndex":2,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":true,"Domain":"Panel","Index":2}],"PanelFilters":[]},"SourceContext":"Model.Cohort.CohortCounter","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4040149-04:00","Level":"Information","MessageTemplate":"Getting preflight resources check. Refs:{@Refs}","Properties":{"Refs":{"_typeTag":"ResourceRefs","Concepts":[{"_typeTag":"ConceptRef","Id":"ddfb3d76-c632-ec11-9c22-000c29db1cc8","UniversalId":null}],"Queries":[],"Imports":[]},"SourceContext":"Model.Search.PreflightResourceChecker","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4179385-04:00","Level":"Information","MessageTemplate":"FullCount panel validation context. Context:{@Context}","Properties":{"Context":{"_typeTag":"PanelValidationContext","QueryId":null,"UniversalId":null,"PreflightCheck":{"_typeTag":"PreflightResources","Ok":true,"DirectConceptsCheck":{"_typeTag":"PreflightConcepts","PreflightCheck":{"_typeTag":"ConceptPreflightCheck","Ok":true,"Results":[{"_typeTag":"ConceptPreflightCheckResult","Id":"ddfb3d76-c632-ec11-9c22-000c29db1cc8","UniversalId":null,"IsPresent":true,"IsAuthorized":true}],"IsPresent":true,"IsAuthorized":true},"Concepts":[{"_typeTag":"Concept","ParentId":"dafb3d76-c632-ec11-9c22-000c29db1cc8","RootId":"dafb3d76-c632-ec11-9c22-000c29db1cc8","ExternalId":"visit:8584","ExternalParentId":"visit","IsNumeric":false,"IsEventBased":false,"IsParent":true,"IsEncounterBased":true,"IsPatientCountAutoCalculated":false,"IsSpecializable":false,"SqlSetFrom":"
                  (SELECT [visit_occurrence_id],
                          [person_id] = CONVERT(NVARCHAR(64), [person_id], 2),
                          [visit_concept_id],
                          [visit_start_date],
                          [visit_start_datetime],
                          [visit_end_date],
                          [visit_end_datetime],
                          [visit_type_concept_id],
                          [provider_id],
                          [care_site_id],
                          [visit_source_value],
                          [visit_source_concept_id],
                          [admitting_source_concept_id],
                          [admitting_source_value],
                          [discharge_to_concept_id],
                          [discharge_to_source_value],
                          [preceding_visit_occurrence_id]
                   FROM omop.cdm_deid.visit_occurrence)
                   ","SqlSetWhere":"/* Mobile Unit */ @.visit_concept_id = 8584","SqlFieldDate":"@.visit_start_datetime","SqlFieldNumeric":null,"SqlFieldEvent":null,"UiDisplayName":"Mobile Unit","UiDisplayText":"Had Mobile Unit encounter","UiDisplaySubtext":null,"UiDisplayUnits":null,"UiDisplayTooltip":null,"UiDisplayEventName":null,"UiDisplayPatientCount":28852,"EventTypeId":null,"SpecializationGroups":[],"UiDisplayPatientCountByYear":null,"UiNumericDefaultText":null,"Id":"ddfb3d76-c632-ec11-9c22-000c29db1cc8","UniversalId":null}],"IsPresent":true,"IsAuthorized":true,"Ok":true},"DirectQueriesCheck":{"_typeTag":"PreflightQueries","Ok":true,"Results":[]},"DirectImportsCheck":{"_typeTag":"PreflightImports","Ok":true,"Results":[]},"GlobalPanelFilters":[]},"Requested":[{"_typeTag":"PanelDTO","Id":"kcwVfwlfm9C","SubPanels":[{"_typeTag":"SubPanelDTO","Id":"9lf3OrInulE","PanelItems":[{"_typeTag":"PanelItemDTO","Id":"wa5-Y7EIb","Resource":{"_typeTag":"ResourceRef","Id":"ddfb3d76-c632-ec11-9c22-000c29db1cc8","UniversalId":null,"UiDisplayName":"Mobile Unit"},"Specializations":[],"NumericFilter":{"_typeTag":"NumericFilter","FilterType":"None","Filter":[]},"RecencyFilter":"None","Index":0,"SubPanelIndex":0,"PanelIndex":0}],"PanelIndex":0,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}},{"_typeTag":"SubPanelDTO","Id":"kOx4_eQpPi","PanelItems":[],"PanelIndex":0,"Index":1,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":false,"Domain":"Panel","Index":0},{"_typeTag":"PanelDTO","Id":"MAnTZydfLKU","SubPanels":[{"_typeTag":"SubPanelDTO","Id":"ysuCNTNjL-p","PanelItems":[],"PanelIndex":1,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":true,"Domain":"Panel","Index":1},{"_typeTag":"PanelDTO","Id":"dgTzjOMJA2f","SubPanels":[{"_typeTag":"SubPanelDTO","Id":"EsbBbGu-cpc","PanelItems":[],"PanelIndex":2,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":true,"Domain":"Panel","Index":2}],"Allowed":[{"_typeTag":"Panel","SubPanels":[{"_typeTag":"SubPanel","PanelItems":[{"_typeTag":"PanelItem","Concept":{"_typeTag":"Concept","ParentId":"dafb3d76-c632-ec11-9c22-000c29db1cc8","RootId":"dafb3d76-c632-ec11-9c22-000c29db1cc8","ExternalId":"visit:8584","ExternalParentId":"visit","IsNumeric":false,"IsEventBased":false,"IsParent":true,"IsEncounterBased":true,"IsPatientCountAutoCalculated":false,"IsSpecializable":false,"SqlSetFrom":"
                   (SELECT [visit_occurrence_id],
                          [person_id] = CONVERT(NVARCHAR(64), [person_id], 2),
                          [visit_concept_id],
                          [visit_start_date],
                          [visit_start_datetime],
                          [visit_end_date],
                          [visit_end_datetime],
                          [visit_type_concept_id],
                          [provider_id],
                          [care_site_id],
                          [visit_source_value],
                          [visit_source_concept_id],
                          [admitting_source_concept_id],
                          [admitting_source_value],
                          [discharge_to_concept_id],
                          [discharge_to_source_value],
                          [preceding_visit_occurrence_id]
                   FROM omop.cdm_deid.visit_occurrence)
                   ","SqlSetWhere":"/* Mobile Unit */ @.visit_concept_id = 8584","SqlFieldDate":"@.visit_start_datetime","SqlFieldNumeric":null,"SqlFieldEvent":null,"UiDisplayName":"Mobile Unit","UiDisplayText":"Had Mobile Unit encounter","UiDisplaySubtext":null,"UiDisplayUnits":null,"UiDisplayTooltip":null,"UiDisplayEventName":null,"UiDisplayPatientCount":28852,"EventTypeId":null,"SpecializationGroups":[],"UiDisplayPatientCountByYear":null,"UiNumericDefaultText":null,"Id":"ddfb3d76-c632-ec11-9c22-000c29db1cc8","UniversalId":null},"Specializations":[],"SqlRecencyFilter":null,"UseNumericFilter":false,"HasSpecializations":false,"UseRecencyFilter":false,"NumericFilter":{"_typeTag":"NumericFilter","FilterType":"None","Filter":[]},"RecencyFilter":"None","Index":0,"SubPanelIndex":0,"PanelIndex":0}],"HasCountFilter":false,"PanelIndex":0,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}},{"_typeTag":"SubPanel","PanelItems":[],"HasCountFilter":false,"PanelIndex":0,"Index":1,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"PanelType":"Sequence","IsDateFiltered":false,"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":false,"Domain":"Panel","Index":0},{"_typeTag":"Panel","SubPanels":[{"_typeTag":"SubPanel","PanelItems":[],"HasCountFilter":false,"PanelIndex":1,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"PanelType":"Patient","IsDateFiltered":false,"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":true,"Domain":"Panel","Index":1},{"_typeTag":"Panel","SubPanels":[{"_typeTag":"SubPanel","PanelItems":[],"HasCountFilter":false,"PanelIndex":2,"Index":0,"IncludeSubPanel":true,"MinimumCount":1,"JoinSequence":{"_typeTag":"SubPanelJoinSequence","Increment":1,"DateIncrementType":"Day","SequenceType":"Encounter"},"DateFilter":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":0,"DateIncrementType":"None"}}],"PanelType":"Patient","IsDateFiltered":false,"DateFilter":{"_typeTag":"DateBoundary","Start":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"},"End":{"_typeTag":"DateFilter","Date":"0001-01-01T00:00:00.0000000","Increment":1,"DateIncrementType":"None"}},"IncludePanel":true,"Domain":"Panel","Index":2}],"PreflightPassed":true},"SourceContext":"Model.Cohort.CohortCounter","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4187151-04:00","Level":"Information","MessageTemplate":"FullCount cohort started.","Properties":{"SourceContext":"Model.Cohort.CohortCounter","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4198903-04:00","Level":"Error","MessageTemplate":"Failed to execute query. Error:{Error}","Properties":{"Error":"System.InvalidOperationException: Sequence contains no elements
   at System.Linq.ThrowHelper.ThrowNoElementsException()
   at System.Linq.Enumerable.First[TSource](IEnumerable`1 source)
   at Model.Compiler.SqlServer.SqlServerCompiler.BuildCteSql(IEnumerable`1 panels) in /var/opt/leafapi/leaf_download/leaf/src/server/Model/Compiler/SqlServer/SqlServerCompiler.cs:line 77
   at Services.Cohort.CtePatientCohortService.GetCteQuery(IEnumerable`1 panels) in /var/opt/leafapi/leaf_download/leaf/src/server/Services/Cohort/CtePatientCohortService.cs:line 68
   at Services.Cohort.CtePatientCohortService.GetCohortAsync(PatientCountQuery query, CancellationToken token) in /var/opt/leafapi/leaf_download/leaf/src/server/Services/Cohort/CtePatientCohortService.cs:line 39
   at Model.Cohort.PatientCohortService.GetPatientCohortAsync(PatientCountQuery query, CancellationToken token) in /var/opt/leafapi/leaf_download/leaf/src/server/Model/Cohort/PatientCohortService.cs:line 38
   at Model.Cohort.CohortCounter.FullCount(IPatientCountQueryDTO queryDTO, CancellationToken token) in /var/opt/leafapi/leaf_download/leaf/src/server/Model/Cohort/CohortCounter.cs:line 202
   at Model.Cohort.CohortCounter.Count(IPatientCountQueryDTO queryDTO, CancellationToken token) in /var/opt/leafapi/leaf_download/leaf/src/server/Model/Cohort/CohortCounter.cs:line 91
   at API.Controllers.CohortCountController.Count(PatientCountQueryDTO patientCountQuery, CohortCounter counter, CancellationToken cancelToken) in /var/opt/leafapi/leaf_download/leaf/src/server/API/Controllers/CohortCountController.cs:line 73","SourceContext":"API.Controllers.CohortCountController","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4201296-04:00","Level":"Information","MessageTemplate":"Executing HttpStatusCodeResult, setting HTTP status code {StatusCode}","Properties":{"StatusCode":500,"EventId":{"Id":1,"Name":"HttpStatusCodeResultExecuting"},"SourceContext":"Microsoft.AspNetCore.Mvc.StatusCodeResult","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","ActionName":"API.Controllers.CohortCountController.Count (API)","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4202470-04:00","Level":"Information","MessageTemplate":"Executed action {ActionName} in {ElapsedMilliseconds}ms","Properties":{"ActionName":"API.Controllers.CohortCountController.Count (API)","ElapsedMilliseconds":17.6717,"EventId":{"Id":2,"Name":"ActionExecuted"},"SourceContext":"Microsoft.AspNetCore.Mvc.Infrastructure.ControllerActionInvoker","ActionId":"c6658bd0-8f03-4f55-88bb-463df6278d6b","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K","SessionId":"1cf31cec-7bc7-40ec-90ca-099bc2836151","User":"arthur.p.goldberg@mssm.edu@urn:leaf:issuer:leaf.mssm.edu"}}
{"Timestamp":"2021-10-27T15:19:03.4204416-04:00","Level":"Information","MessageTemplate":"{HostingRequestFinishedLog:l}","Properties":{"ElapsedMilliseconds":19.3446,"StatusCode":500,"ContentType":null,"HostingRequestFinishedLog":"Request finished in 19.3446ms 500 ","EventId":{"Id":2},"SourceContext":"Microsoft.AspNetCore.Hosting.Diagnostics","RequestId":"0HMCG75CL2S2K:00000001","RequestPath":"/api/cohort/count","SpanId":"|3ddca57c-4ed98015d72ea9f4.","TraceId":"3ddca57c-4ed98015d72ea9f4","ParentId":"","ConnectionId":"0HMCG75CL2S2K"},"Renderings":{"HostingRequestFinishedLog":[{"Format":"l","Rendering":"Request finished in 19.3446ms 500 "}]}}
{"Timestamp":"2021-10-27T15:19:03.9677948-04:00","Level":"Information","MessageTemplate":"Refreshed TokenBlacklistCache","Properties":{"SourceContext":"API.Jobs.BackgroundTokenBlacklistSynchronizer"}}

2021-10-27 full log of not patients error.txt

ndobb commented 2 years ago

Hi @artgoldberg, thanks for posting. The larger issue is that there is no inclusion criteria in the query, only exclusion, and the UI is (mistakenly) allowing this. It probably should not and we'll likely need to fix this.

The actual error is due to the fact that as the API attempts to build the SQL statement, it attempts to begin by grabbing the first Inclusion Panel, but there are none. The "First" in System.Linq.ThrowHelper.ThrowNoElementsException() at System.Linq.Enumerable.First[TSource](IEnumerable1 source) provided me the clue for this.