Share via

Spatial Analysis container not sending messages to IoT Hub

mateusz.peczek 16 Reputation points
2021-05-19T08:39:16.247+00:00

Hi, I'm trying to run Spatial Analysis container using Azure Stack Edge device from this tutorial:

https://learn.microsoft.com/en-us/azure/cognitive-services/computer-vision/spatial-analysis-web-app

I was able to set container into running state reported by IoT Edge, but no messages are sent to my IoT Hub.

Logs retrieved by SpatialAnalysis-diagnostics shows, that graph cannot be initialized.
I had a two 5 second periods when solutions was working (sending about 40 messages each time) overnight, but I can't find any reason why it worked and why it doesn't all the time.

My current logs shows those messages: 

2021-05-19T07:38:59.088987133Z 2021-05-19T07:38:59.08890773Z <info> 25 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.edgehubclient exclude=map[]  
2021-05-19T07:38:59.088990833Z 2021-05-19T07:38:59.08891253Z <verbose> 25 [Archon] Check AllNodesRunning nodeid=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.edgehubclient state=SYSTEM_STATE_INITIALIZED  
2021-05-19T07:38:59.089000433Z 2021-05-19T07:38:59.08891553Z <info> 25 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.videosource exclude=map[]  
2021-05-19T07:38:59.089003433Z 2021-05-19T07:38:59.08891833Z <verbose> 25 [Archon] Check AllNodesRunning nodeid=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.videosource state=SYSTEM_STATE_INITIALIZED  
2021-05-19T07:38:59.089006334Z 2021-05-19T07:38:59.08892083Z <info> 25 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.detectionskipper exclude=map[]  
2021-05-19T07:38:59.089009434Z 2021-05-19T07:38:59.08892353Z <verbose> 25 [Archon] Check AllNodesRunning nodeid=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.detectionskipper state=SYSTEM_STATE_INITIALIZED  
2021-05-19T07:38:59.089012134Z 2021-05-19T07:38:59.088925931Z <info> 25 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.tracker exclude=map[]  
2021-05-19T07:38:59.089015234Z 2021-05-19T07:38:59.088928731Z <verbose> 25 [Archon] Check AllNodesRunning nodeid=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.tracker state=SYSTEM_STATE_INITIALIZED  
2021-05-19T07:38:59.089018034Z 2021-05-19T07:38:59.088931431Z <info> 25 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.spaceanalytics exclude=map[]  
2021-05-19T07:38:59.089020834Z 2021-05-19T07:38:59.088942831Z <verbose> 25 [Archon] Check AllNodesRunning nodeid=cognitiveservices_vision_spatialanalysis_1.checkoutline.spatialanalysisgraph.spaceanalytics state=SYSTEM_STATE_INITIALIZED  
2021-05-19T07:38:59.089024034Z 2021-05-19T07:38:59.088945531Z <info> 25 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.shareddetector exclude=map[]  
2021-05-19T07:38:59.089026934Z 2021-05-19T07:38:59.088949231Z <verbose> 25 [Archon] Check AllNodesRunning nodeid=cognitiveservices_vision_spatialanalysis_1.shareddetector state=SYSTEM_STATE_NONE  
2021-05-19T07:38:59.089029734Z 2021-05-19T07:38:59.088952132Z <warning> 25 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.shareddetector nodestate=SYSTEM_STATE_NONE  
2021-05-19T07:38:59.177149280Z 2021-05-19T07:38:59.177039376Z <warning> 25 [Archon] Tick 288, waiting for graph to be ready

After tick is increased to 299, Timeout is reported.

After that, this part of logs is show in a loop every minute: 

2021-05-19T12:24:36.143889396Z 2021-05-19T12:24:36.143826593Z <verbose> 25 [Archon] Sending Billing record CognitiveServices.ComputerVision.Container.PeopleAnalyticsUsage  
2021-05-19T12:24:36.144776528Z 2021-05-19T12:24:36.1446721+00:00 <info> 110 [Launcher] Request starting HTTP/1.1 POST http://localhost:5000/billing/trackUsage/CognitiveServices.ComputerVision.Container.PeopleAnalyticsUsage/60 application/json   
2021-05-19T12:24:36.144784329Z 2021-05-19T12:24:36.1447467+00:00 <info> 110 [Launcher] Executing endpoint 'PEngineModule.BillingService.Controllers.BillingController.PostUsageMeter (BillingService)'  
2021-05-19T12:24:36.144892033Z 2021-05-19T12:24:36.1448263+00:00 <info> 110 [Launcher] Route matched with {action = "PostUsageMeter", controller = "Billing"}. Executing controller action with signature Microsoft.AspNetCore.Mvc.IActionResult PostUsageMeter(System.String, Double) on controller PEngineModule.BillingService.Controllers.BillingController (BillingService).  
2021-05-19T12:24:36.145024637Z 2021-05-19T12:24:36.1449674+00:00 <info> 110 [Launcher] Executing action method PEngineModule.BillingService.Controllers.BillingController.PostUsageMeter (BillingService) - Validation state: Valid  
2021-05-19T12:24:36.145029938Z 2021-05-19T12:24:36.1449909+00:00 <info> 110 [Launcher] Posted Usage Successfully  
2021-05-19T12:24:36.145105240Z 2021-05-19T12:24:36.1450080+00:00 <info> 110 [Launcher] Executed action method PEngineModule.BillingService.Controllers.BillingController.PostUsageMeter (BillingService), returned result Microsoft.AspNetCore.Mvc.OkResult in 0.0186ms.  
2021-05-19T12:24:36.145121641Z 2021-05-19T12:24:36.1450628+00:00 <info> 110 [Launcher] Executing HttpStatusCodeResult, setting HTTP status code 200  
2021-05-19T12:24:36.145127241Z 2021-05-19T12:24:36.1450860+00:00 <info> 110 [Launcher] Executed action PEngineModule.BillingService.Controllers.BillingController.PostUsageMeter (BillingService) in 0.2421ms  
2021-05-19T12:24:36.145130341Z 2021-05-19T12:24:36.1450978+00:00 <info> 110 [Launcher] Executed endpoint 'PEngineModule.BillingService.Controllers.BillingController.PostUsageMeter (BillingService)'  
2021-05-19T12:24:36.145207644Z 2021-05-19T12:24:36.1451481+00:00 <info> 110 [Launcher] Request finished in 0.4886ms 200   
2021-05-19T12:24:36.145216845Z 2021-05-19T12:24:36.1451796+00:00 <info> 110 [Launcher] Connection id "0HM8QIU8LMGPV", Request id "0HM8QIU8LMGPV:00000001": the application completed without reading the entire request body.  
2021-05-19T12:25:06.144847368Z 2021-05-19T12:25:06.1447163+00:00 <info> 102 [Launcher] Reporting meter usage of 60 units at 637570239061446981.  
2021-05-19T12:25:06.226984836Z 2021-05-19T12:25:06.2268580+00:00 <info> 103 [Launcher] ApimMetering:Send 2021-05-19T12:25:06 82.0939 True 200  
2021-05-19T12:25:34.559444668Z 2021-05-19T12:25:34.55929246Z <info> 25 [Archon] poll status data at 2021-05-19 12:25:34.559273259 +0000 UTC m=+17881.498788113  
2021-05-19T12:25:34.559474069Z 2021-05-19T12:25:34.559333962Z <verbose> 25 [Archon] Getting state properties for graph=cognitiveservices_vision_spatialanalysis_1 instance=checkoutLine  
2021-05-19T12:25:34.559478469Z 2021-05-19T12:25:34.559345163Z <verbose> 25 [Archon] Property change for graph='cognitiveservices_vision_spatialanalysis_1', instance='checkoutLine' remains unchanged  
2021-05-19T12:25:36.145613460Z 2021-05-19T12:25:36.145426455Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_graphHeartbeat Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145645861Z 2021-05-19T12:25:36.145506057Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.145503557 +0000 UTC m=+17883.085018411 1.0 archon_graphHeartbeat info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145737063Z 2021-05-19T12:25:36.145654161Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.145759063Z 2021-05-19T12:25:36.145668261Z <verbose> 25 [Archon] Sending telemetry &{TimeStamp:2021-05-19 12:25:36.145503557 +0000 UTC m=+17883.085018411 Version:1.0 Name:archon_graphHeartbeat Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145763964Z 2021-05-19T12:25:36.145699062Z <verbose> 25 [Archon] successfully sent telemetry through provider: PrometheusTelemetryProvider  
2021-05-19T12:25:36.145767264Z 2021-05-19T12:25:36.145707562Z <verbose> 25 [Archon] platform telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.145682362 +0000 UTC m=+17883.085197216 1.0 archon_graphHeartbeat info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145778564Z 2021-05-19T12:25:36.145720563Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:videoSource archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145782864Z 2021-05-19T12:25:36.145742763Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.145741463 +0000 UTC m=+17883.085256317 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:videoSource archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145861666Z 2021-05-19T12:25:36.145805065Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.145871866Z 2021-05-19T12:25:36.145816565Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:detectionSkipper archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145878366Z 2021-05-19T12:25:36.145827065Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.145825965 +0000 UTC m=+17883.085340819 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:detectionSkipper archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145945768Z 2021-05-19T12:25:36.145887567Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.145975369Z 2021-05-19T12:25:36.145900767Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:tracker archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.145985469Z 2021-05-19T12:25:36.145939968Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.145938568 +0000 UTC m=+17883.085453422 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:tracker archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146049671Z 2021-05-19T12:25:36.14600087Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146054771Z 2021-05-19T12:25:36.14601327Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:spaceanalytics archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146058371Z 2021-05-19T12:25:36.14602397Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.14602287 +0000 UTC m=+17883.085537824 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:spaceanalytics archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146135573Z 2021-05-19T12:25:36.146068471Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146145573Z 2021-05-19T12:25:36.146078672Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:edgehubclient archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146153673Z 2021-05-19T12:25:36.146089072Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.146087972 +0000 UTC m=+17883.085602926 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:edgehubclient archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146190774Z 2021-05-19T12:25:36.146138973Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146199775Z 2021-05-19T12:25:36.146150073Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:facemask archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146211475Z 2021-05-19T12:25:36.146160474Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.146159274 +0000 UTC m=+17883.085674128 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:facemask archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146257576Z 2021-05-19T12:25:36.146211975Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146265476Z 2021-05-19T12:25:36.146218475Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:diagnostics archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146283677Z 2021-05-19T12:25:36.146231975Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.146228875 +0000 UTC m=+17883.085743829 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:diagnostics archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146336478Z 2021-05-19T12:25:36.146280577Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146343878Z 2021-05-19T12:25:36.146289277Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:skipper archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146349578Z 2021-05-19T12:25:36.146299977Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.146298777 +0000 UTC m=+17883.085813731 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:skipper archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146392379Z 2021-05-19T12:25:36.146341578Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146402180Z 2021-05-19T12:25:36.146356779Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:detector archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146438381Z 2021-05-19T12:25:36.146370479Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.146369179 +0000 UTC m=+17883.085884133 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:detector archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146447681Z 2021-05-19T12:25:36.14641418Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146453581Z 2021-05-19T12:25:36.14642138Z <verbose> 25 [Archon] Sending internal telemetry &{TimeStamp:0001-01-01 00:00:00 +0000 UTC Version:1.0 Name:archon_nodeUsage Severity:info Properties:map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:classificationresultaggregator archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146484182Z 2021-05-19T12:25:36.146434281Z <verbose> 25 [Archon] customer telemetry feature is disabled the following event was not sent: &{2021-05-19 12:25:36.14643288 +0000 UTC m=+17883.085947734 1.0 archon_nodeUsage info map[archon_graphId:cognitiveservices_vision_spatialanalysis_1 archon_graphInstanceId:checkoutLine archon_nodeId:classificationresultaggregator archon_operationId:cognitiveservices.vision.spatialanalysis]}  
2021-05-19T12:25:36.146522683Z 2021-05-19T12:25:36.146481882Z <verbose> 25 [Archon] successfully sent telemetry through provider: AriaTelemetryProvider  
2021-05-19T12:25:36.146528483Z 2021-05-19T12:25:36.146494582Z <verbose> 25 [Archon] Sending Billing record CognitiveServices.ComputerVision.Container.PeopleAnalyticsUsage

I'm using simplified configuration specified in example with less instances to reduce risk of potential problems. 

"properties": {  
        "desired": {  
            "globalSettings": {  
                "platformTelemetryEnabled": true,  
                "customerTelemetryEnabled": true,  
                "platformLogLevel": "debug",  
                "nodesLogLevel": "debug",  
                "diagnosticsEnabled": true  
            },  
            "graphs": {  
                "cognitiveservices_vision_spatialanalysis_1": {  
                    "operationId": "cognitiveservices.vision.spatialanalysis",  
                    "parameters": {  
                        "INPUT_VIDEO_WIDTH": 1920  
                    },  
                    "sharedNodes": {  
                        "sharedDetector": {  
                            "node": "SpatialAnalysisGraph/detector",  
                            "parameters": {  
                                "DETECTOR_NODE_CONFIG": "{\"gpu_index\":1}"  
                            }  
                        },  
                        "sharedFacemask": {  
                            "node": "SpatialAnalysisGraph/facemask",  
                            "parameters": {  
                                "VIDEO_DECODE_GPU_INDEX": 1,  
                                "ENABLE_FACE_MASK_CLASSIFIER": true  
                            }  
                        }  
                    },  
                    "instances": {  
                        "checkoutLine": {  
                            "sharedNodeMap": {  
                                "SpatialAnalysisGraph/detector": "sharedDetector",  
                                "SpatialAnalysisGraph/facemask": "sharedFacemask"  
                            },  
                            "parameters": {  
                                "VIDEO_URL": "https://teamfileshare.blob.core.windows.net/spatialanalysis-demo-data/line-crossing.mp4?sp=r&st=2021-04-26T22:53:17Z&se=2024-04-27T06:53:17Z&spr=https&sv=2020-02-10&sr=b&sig=sfy4Z%2BQPnMnL2wqA5F0Mw0VVGIoqHG1vtr0IhvhqCuI%3D",  
                                "VIDEO_SOURCE_ID": "Checkout Area",  
                                "VIDEO_IS_LIVE": false,  
                                "VIDEO_DECODE_GPU_INDEX": 1,  
                                "SPACEANALYTICS_CONFIG": "{\"zones\":[{\"name\":\"queue\",\"polygon\":[[0.348,0.512],[0.764,0.687],[0.662,0.927],[0.221,0.605],[0.348,0.512]], \"events\": [{\"type\":\"zonecrossing\", \"config\":{\"trigger\": \"event\", \"threshold\":0.0, \"focus\": \"footprint\"}}, {\"type\":\"zonedwelltime\", \"config\":{\"trigger\": \"event\", \"threshold\":0.0, \"focus\": \"footprint\"}}]}]}"  
                            },  
                            "enabled": true  
                        }  
                    },  
                    "enabled": true  
                }  
            },

Current documentation lacks a lot in terms any information about possible errors and issues.

Thanks for help

Azure AI services
Azure AI services
A group of Azure services, SDKs, and APIs designed to make apps more intelligent, engaging, and discoverable.
2,866 questions

1 answer

Sort by: Most helpful
Most helpful Newest Oldest
  1. Apurba Das 1 Reputation point
    2021-06-10T12:48:38.36+00:00

    Hi,

    I am also facing the same issue and stuck at this step. Is the issue resolved? Please help me to solve the problem

    2021-06-10T12:22:10.383858975Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:10.483690623Z <warning> 28 [Archon] Tick 166, waiting for agents to be ready
    2021-06-10T12:22:10.483740422Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.harvester exclude=map[]
    2021-06-10T12:22:10.483780120Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.tracker exclude=map[]
    2021-06-10T12:22:10.483809119Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.edgehubclient exclude=map[]
    2021-06-10T12:22:10.483839018Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:10.483866117Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:10.483891016Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:10.483918415Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:10.583704065Z <warning> 28 [Archon] Tick 167, waiting for agents to be ready
    2021-06-10T12:22:10.583735864Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detectionskipper exclude=map[]
    2021-06-10T12:22:10.583807961Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classifier exclude=map[]
    2021-06-10T12:22:10.583834960Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:10.583866159Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:10.583893058Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:10.583920857Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:10.583949956Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:10.583977855Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:10.584003754Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:10.683708506Z <warning> 28 [Archon] Tick 168, waiting for agents to be ready
    2021-06-10T12:22:10.683745805Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.edgehubclient exclude=map[]
    2021-06-10T12:22:10.683786204Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.harvester exclude=map[]
    2021-06-10T12:22:10.683815803Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.tracker exclude=map[]
    2021-06-10T12:22:10.683843702Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:10.683872400Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:10.683897200Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:10.683924799Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:10.683950898Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:10.683978597Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:10.684002896Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:10.783708248Z <warning> 28 [Archon] Tick 169, waiting for agents to be ready
    2021-06-10T12:22:10.783739147Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:10.783772546Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:10.783801045Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:10.783827244Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:10.883716290Z <warning> 28 [Archon] Tick 170, waiting for agents to be ready
    2021-06-10T12:22:10.883749789Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:10.883786787Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:10.883816686Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:10.883841885Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:10.883871084Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:10.883904783Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:10.883932682Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:10.983713032Z <warning> 28 [Archon] Tick 171, waiting for agents to be ready
    2021-06-10T12:22:10.983750831Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detectionskipper exclude=map[]
    2021-06-10T12:22:10.983783329Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classifier exclude=map[]
    2021-06-10T12:22:10.983811828Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:10.983844527Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:10.983870126Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:10.983897825Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:10.983926524Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:10.983951423Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:10.983978822Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:11.0471303+00:00 <info> 102 [Launcher] KeyRequest:Send 2021-06-10T12:22:05 5495.6736 True 200
    2021-06-10T12:22:11.083715074Z <warning> 28 [Archon] Tick 172, waiting for agents to be ready
    2021-06-10T12:22:11.083770072Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detectionskipper exclude=map[]
    2021-06-10T12:22:11.083806871Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classifier exclude=map[]
    2021-06-10T12:22:11.083835470Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:11.083863669Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:11.083889168Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:11.083914067Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:11.083939166Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:11.083963665Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:11.083987964Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:11.183695317Z <warning> 28 [Archon] Tick 173, waiting for agents to be ready
    2021-06-10T12:22:11.183787914Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:11.183824412Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:11.183849611Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:11.183880110Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:11.183905009Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:11.183932008Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:11.283692459Z <warning> 28 [Archon] Tick 174, waiting for agents to be ready
    2021-06-10T12:22:11.283743657Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:11.283778656Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:11.283807755Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:11.3209964+00:00 <info> 103 [Launcher] Executed action method PEngineModule.IPProtectionService.Controllers.IPProtectionController.decrypt (IPProtection), returned result Microsoft.AspNetCore.Mvc.FileStreamResult in 6131.9532ms.
    2021-06-10T12:22:11.3210753+00:00 <info> 103 [Launcher] Executing Microsoft.AspNetCore.Mvc.FileStreamResult, sending file with download name '' ...
    2021-06-10T12:22:11.383715901Z <warning> 28 [Archon] Tick 175, waiting for agents to be ready
    2021-06-10T12:22:11.383766399Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.edgehubclient exclude=map[]
    2021-06-10T12:22:11.383799998Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.harvester exclude=map[]
    2021-06-10T12:22:11.383831396Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.tracker exclude=map[]
    2021-06-10T12:22:11.383859895Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detectionskipper exclude=map[]
    2021-06-10T12:22:11.383890894Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classifier exclude=map[]
    2021-06-10T12:22:11.383919793Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:11.383950992Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:11.383979191Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:11.384007490Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:11.384036389Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:11.384089387Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:11.384133885Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:11.4706804+00:00 <info> 102 [Launcher] Executed action PEngineModule.IPProtectionService.Controllers.IPProtectionController.decrypt (IPProtection) in 6281.8328ms
    2021-06-10T12:22:11.4707370+00:00 <info> 102 [Launcher] Executed endpoint 'PEngineModule.IPProtectionService.Controllers.IPProtectionController.decrypt (IPProtection)'
    2021-06-10T12:22:11.4707678+00:00 <info> 102 [Launcher] Request finished in 6282.1605ms 200 application/octet-stream
    2021-06-10T12:22:11.483694044Z <warning> 28 [Archon] Tick 176, waiting for agents to be ready
    2021-06-10T12:22:11.483748442Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.edgehubclient exclude=map[]
    2021-06-10T12:22:11.483784640Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.harvester exclude=map[]
    2021-06-10T12:22:11.483815539Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.tracker exclude=map[]
    2021-06-10T12:22:11.483845338Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.classificationresultaggregator exclude=map[]
    2021-06-10T12:22:11.483877637Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.videosource exclude=map[]
    2021-06-10T12:22:11.483903036Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.skipper exclude=map[]
    2021-06-10T12:22:11.483930935Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.spaceanalytics exclude=map[]
    2021-06-10T12:22:11.483967434Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.facemask exclude=map[]
    2021-06-10T12:22:11.483992633Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:11.484022732Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    2021-06-10T12:22:11.583692786Z <warning> 28 [Archon] Tick 177, waiting for agents to be ready
    2021-06-10T12:22:11.583745284Z <info> 28 [Archon] AllNodesRunning check nrt.Id=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector exclude=map[]
    2021-06-10T12:22:11.583779883Z <warning> 28 [Archon] AllNodesRunning() found a node not ready. nodeid=cognitiveservices_vision_spatialanalysis_1.store.spatialanalysisgraph.detector nodestate=SYSTEM_STATE_NONE
    Showing last 1500 line(s)

    0 comments

Your answer

Answers can be marked as Accepted Answers by the question author, which helps users to know the answer solved the author's problem.