search

Azure / azure-spatial-anchors-samples

Azure Spatial Anchors sample code
Other
293 stars 139 forks source link

Unable to localize when using Android NDK #51

Closed JaimeIvanCervantes closed 4 years ago

JaimeIvanCervantes commented 5 years ago

I am trying to use spatial anchors on my purely C++ Android project, but have not been able to localize anchors; I can confirm that the anchors are being uploaded to Azure, and the ID is being found when I query the anchors, but for some reason I keep seeing LocateAnchorStatus::NotLocated and wasRelocalized[0] on the logs. I even used CloudSpatialAnchorSessionDiagnostics to save keyframes, and everything seems correct. I am also creating the anchors at identity every-time. Is there a recommended way to diagnose localization issues? I have been trying to debug this issue for a few days without success.

As part of my pure C++ project, I am initializing Microsoft's CloudServices from C++, and I am also starting/destroying the session, creating anchors, and querying anchors on a OpenGL context created on the C++ side. Here's the simplified code (the render method is called by a method similar to OpenGL's onDrawFrame):

Session::Session() {
    jobject activity = helpers::getMainActivity();

    jclass cloudServicesClass = env->FindClass("com/microsoft/CloudServices");

    jmethodID initializeCloudServices = env->GetStaticMethodID(cloudServicesClass, "initialize", "(Landroid/content/Context;)V");

    env->CallStaticVoidMethod(cloudServicesClass, initializeCloudServices, activity);

    env->DeleteLocalRef(activity);
}

Session::run() {
    _spatialAnchorState = SpatialAnchorState::createSession;
}

Session::render() {
   ArStatus status;

    ArSession_setCameraTextureName(_platformSession, _textureHandle);

    status = ArSession_update(_platformSession, _currentPlatformFrame);

    switch (_spatialAnchorState) {
        case SpatialAnchorState::createSession: {
            createSpatialAnchorSession();
            _spatialAnchorState = SpatialAnchorState::sessionCreated;
        }
            break;
        case SpatialAnchorState::createAnchor: {
            createSpatialAnchor();
            _spatialAnchorState = SpatialAnchorState::anchorCreated;
        }
            break;
        case SpatialAnchorState::queryAnchor: {
            querySpatialAnchor();
            _spatialAnchorState = SpatialAnchorState::anchorQueried;
        }
            break;
        case SpatialAnchorState::destroySession: {
            destroySpatialAnchorSession();
            _spatialAnchorState = SpatialAnchorState::sessionDestroyed;
        }
            break;
    }

    if (_cloudSpatialAnchorSession != nullptr) {
        _cloudSpatialAnchorSession->ProcessFrame(_currentPlatformFrame);
    }
}

void Session::createSpatialAnchorSession(bool withDiagnostics) {
    _cloudSpatialAnchorSession = std::make_shared<Microsoft::Azure::SpatialAnchors::CloudSpatialAnchorSession>();
    _cloudSpatialAnchorSession->Session(_platformSession);
    _cloudSpatialAnchorSession->Configuration()->AccountId(SpatialAnchorsAccountId);
    _cloudSpatialAnchorSession->Configuration()->AccountKey(SpatialAnchorsAccountKey);
    _cloudSpatialAnchorSession->LogLevel(Microsoft::Azure::SpatialAnchors::SessionLogLevel::All);
​
    if (withDiagnostics) {
        _cloudSpatialAnchorSessionDiagnostics = _cloudSpatialAnchorSession->Diagnostics();
        _cloudSpatialAnchorSessionDiagnostics->LogLevel(
                Microsoft::Azure::SpatialAnchors::SessionLogLevel::All);
        _cloudSpatialAnchorSessionDiagnostics->LogDirectory("/mnt/sdcard/diagnostics");
        _cloudSpatialAnchorSessionDiagnostics->ImagesEnabled(true);
        _cloudSpatialAnchorSessionDiagnostics->MaxDiskSizeInMB(2000);
    }
​
    _errorToken = _cloudSpatialAnchorSession->Error([](auto&&, auto&& args) {
        auto errorCode = args->ErrorCode();
        auto errorMessage = args->ErrorMessage();
        std::cout << "MS error code: " << errorMessage << static_cast<int>(errorCode);
    });
​
    _onLogDebugToken = _cloudSpatialAnchorSession->OnLogDebug([](auto&&, auto&& args) {
        auto message = args->Message();
        std::cout << "MS debug message: " << message;
    });
​
    _sessionUpdatedToken = _cloudSpatialAnchorSession->SessionUpdated([this](auto&&, auto&& args) {
        auto status = args->Status();
        bool progressOnSavingData = status->RecommendedForCreateProgress() >= 1.0f;
        if (progressOnSavingData) {
            std::ostringstream str;
            std::cout << "MS progress is " << (status->RecommendedForCreateProgress() * 100) << "%";
        }
    });
​
    _anchorLocatedToken = _cloudSpatialAnchorSession->AnchorLocated([this](auto &&, auto &&args) {
        switch (args->Status()) {
            case LocateAnchorStatus::AlreadyTracked: {
                std::cout << "spatial-anchor already tracked";
            }
                break;
            case LocateAnchorStatus::Located: {
                std::cout << "spatial-anchor located";
            }
                break;
            case LocateAnchorStatus::NotLocated: {
                std::cout << "spatial-anchor not located";
            }
                break;
            case LocateAnchorStatus::NotLocatedAnchorDoesNotExist: {
                std::cout << "spatial-anchor Does not exist";
            }
                break;
        }
    });
​
    _locateAnchorsCompletedToken = _cloudSpatialAnchorSession->LocateAnchorsCompleted(
            [this](auto &&, auto &&args) {
                std::cout << "Locate anchor completed";
            });
​
    _cloudSpatialAnchorSession->Start();
}
​
void Session::createSpatialAnchor() {
    if (!_localAnchor) {
        std::cout << "Local anchor is NULL on spatial-anchor creation";
        return;
    }
​
    ArTrackingState arTrackingState = AR_TRACKING_STATE_STOPPED;
    ArAnchor_getTrackingState(_platformSession, _localAnchor, &arTrackingState);
    if (arTrackingState != AR_TRACKING_STATE_TRACKING) {
        std::cout << "Local anchor tracking state is not valid on spatial-anchor creation";
        return;
    }
​
    _spatialAnchor = std::make_shared<Microsoft::Azure::SpatialAnchors::CloudSpatialAnchor>();
    _spatialAnchor->LocalAnchor(_localAnchor);
​
    std::chrono::system_clock::time_point now = std::chrono::system_clock::now();
    std::chrono::system_clock::time_point oneWeekFromNow = now + std::chrono::hours(3 * 24);
    const int64_t oneWeekFromNowUnixEpochTimeMs = std::chrono::duration_cast<std::chrono::milliseconds>(oneWeekFromNow.time_since_epoch()).count();
    _spatialAnchor->Expiration(oneWeekFromNowUnixEpochTimeMs);
​
    _cloudSpatialAnchorSession->CreateAnchorAsync(_spatialAnchor, [this](Status status) {
        if (status != Status::OK) {
          std::cout << "Unable to create MS Azure spatial-anchor with status: " << static_cast<int>(status);
          return;
        }
​
       // TODO: Handle created anchor here 
​
        _spatialAnchorState = SpatialAnchorState::destroySession;
    }
    );
}
​
void Session::querySpatialAnchor() {
    if (_spatialAnchorId.empty()) {
        std::cout << "spatial-anchor ID is empty on query";
        return;
    }

    if (_cloudSpatialAnchorWatcher != nullptr)
    {
        _cloudSpatialAnchorWatcher->Stop();
        _cloudSpatialAnchorWatcher.reset();
    }
​
    auto criteria = std::make_shared<AnchorLocateCriteria>();
​
    criteria->Identifiers({_spatialAnchorId});
​
    _cloudSpatialAnchorWatcher = _cloudSpatialAnchorSession->CreateWatcher(criteria);
}
​
void Session::destroySpatialAnchorSession() {
    if (_cloudSpatialAnchorSession != nullptr)
    {
        _cloudSpatialAnchorSession->SessionUpdated(_sessionUpdatedToken);
        _cloudSpatialAnchorSession->OnLogDebug(_onLogDebugToken);
        _cloudSpatialAnchorSession->Error(_errorToken);
        _cloudSpatialAnchorSession->AnchorLocated(_anchorLocatedToken);
        _cloudSpatialAnchorSession->LocateAnchorsCompleted(_locateAnchorsCompletedToken);
​
        _cloudSpatialAnchorSession->Stop();
        _cloudSpatialAnchorSession.reset();
    }
​
    if (_cloudSpatialAnchorSessionDiagnostics) {
        _cloudSpatialAnchorSessionDiagnostics.reset();
        _cloudSpatialAnchorSessionDiagnostics = nullptr;
    }
​
    if (_cloudSpatialAnchorWatcher != nullptr) {
        _cloudSpatialAnchorWatcher->Stop();
        _cloudSpatialAnchorWatcher.reset();
    }
​
    if (_spatialAnchor) {
        _spatialAnchor.reset();
        _spatialAnchor = nullptr;
    }
}

I am also not seeing any session->Error([](auto&&, auto&& args) errors, so everything seems to be working as expected, except that the anchors are never localized.

Here are the logs for anchor creation:

07-26 15:43:40.905 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.905750000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Session Identifier: 8aa494d9-f799-46ef-89c0-b27424e20939 [AUTOMATION]
07-26 15:43:40.905 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.905837000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured AnchorServiceUrl: https://manage.sa.mixedreality.azure.com/
07-26 15:43:40.905 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.905874000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured AuthServiceUrl: https://sts.mixedreality.azure.com/
07-26 15:43:40.905 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.905909000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured AccountId: [removed]
07-26 15:43:40.905 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.905952000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured DeviceOsVersion: 7.0
07-26 15:43:40.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.905983000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured SdkPackageType: 
07-26 15:43:40.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.906014000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured SdkVersion: 1.1.1
07-26 15:43:40.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.906043000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured ArPlatformVersion: 7.0
07-26 15:43:40.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.906073000 UTC][3752651040][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured MiddlewareVersions: 
07-26 15:43:40.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:40.906893000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::MobileNeighborhoodManager] Initialized the mobile neighborhood manager.
07-26 15:43:42.472 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:42.472281000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:42.472 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:42.472369000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:42.472 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:42.472832000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:42.531 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:42.531399000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '5e0dbfda63a8f840bf2b7aae9c85c683' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:42.531 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:42.531594000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:42.531 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:42.531624000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:42.531 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:42.531653000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:44.294 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:44.294141000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:44.294 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:44.294247000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:44.295 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:44.294942000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:44.371 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.371119000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '9af6f73d4676ee479f5344d425ec643c' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:44.371 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.371286000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:44.371 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.371350000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:44.371 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.371415000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:44.763 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:44.763551000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:44.763 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:44.763670000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:44.779 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:44.779067000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:44.847 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.847213000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'cb0a6cfea44b8f44bf5b50e1f376f126' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:44.847 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.847490000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:44.847 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.847566000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:44.847 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:44.847642000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:45.771 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:45.771913000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:45.772 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:45.772051000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:45.772 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:45.772791000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:45.855 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:45.855753000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '3057aff7b177cd4aa80e98201c89097b' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:45.856 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:45.856409000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:45.856 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:45.856483000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:45.856 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:45.856556000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:46.113 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:46.113567000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:46.113 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:46.113673000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:46.114 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:46.114294000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:46.190 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.190630000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '498f0fbc27ad184d9ed44114ba96ddbe' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:46.191 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.191002000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:46.191 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.191055000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:46.191 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.191133000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:46.442 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:46.442325000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:46.442 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:46.442448000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:46.450 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:46.450825000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:46.538 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.538143000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '8cb131392ce36f4993b7e1788c03b348' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:46.538 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.538407000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:46.538 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.538475000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:46.538 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:46.538540000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:47.483 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.483270000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:47.483 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.483375000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:47.490 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.490802000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:47.563 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.563204000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'dc587d6419f372439a0f9bfcfc3aaf84' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:47.563 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.563373000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:47.563 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.563413000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:47.563 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.563454000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:47.665 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.665332000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:47.665 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.665442000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:47.675 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.675092000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:47.769 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.769753000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '7055b53ae5d34c41adc0220b03ee5cb8' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:47.770 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.769973000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:47.770 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.770033000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:47.770 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:47.770093000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:47.943 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.943777000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:47.943 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.943868000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:47.944 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:47.944207000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:48.003 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.3349000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '1a987b3eb253574aa11cdf21f08d8ee2' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:48.003 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.3536000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:48.003 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.3573000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:48.003 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.3623000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:48.509 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.509696000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:48.509 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.509829000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:48.510 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.510196000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:48.573 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.573253000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'bb744f496b225d4e89e9eaea5bd3f981' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:48.573 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.573550000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:48.573 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.573610000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:48.573 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.573667000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:48.879 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.879594000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:48.879 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.879674000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:48.880 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.879990000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:48.965 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.965625000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '42202b514178f544896381401863a949' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:48.965 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.965852000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:48.965 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.965902000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:48.965 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:48.965952000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:48.991 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.990938000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:48.991 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.991066000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:48.995 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:48.995347000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:49.051 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.51159000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '996949349e4e5742b67e8189dd082047' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:49.051 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.51321000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:49.051 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.51362000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:49.051 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.51403000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:49.239 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.239840000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:49.240 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.239984000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:49.240 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.240300000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:49.315 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.315750000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '6ab750635dd73a4f9dee9c214218ff3f' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:49.316 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.315972000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:49.316 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.316033000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:49.316 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.316095000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:49.596 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.596427000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:49.596 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.596539000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:49.599 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.599756000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:49.693 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.693529000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'e1737284a4ee7f4e8458950c92391642' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:49.693 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.693871000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:49.693 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.693952000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:49.694 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.694030000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:49.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.906105000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:49.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.906201000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:49.906 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:49.906613000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:49.997 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.997439000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '4bb4996a81eb2d4784586437dfcfa175' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:49.997 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.997740000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:49.997 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.997798000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:49.997 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:49.997852000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:50.143 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.143052000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:50.143 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.143112000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:50.143 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.143380000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:50.185 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.185384000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'adce430a53d51d49a8dd0dffd2d9d4ca' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:50.185 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.185573000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:50.185 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.185602000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:50.185 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.185632000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:50.477 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.477837000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:50.477 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.477884000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:50.478 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.478234000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:50.514 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.514841000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'cc095fd95bbc244aa7db016bc3a3e9d0' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:50.515 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.514996000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:50.515 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.515024000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:50.515 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.515053000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:50.728 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.728678000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:50.728 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.728811000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:50.734 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:50.734389000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:50.833 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.833738000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'b835d7c64bfbc746911208d50b3cc9c2' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:50.834 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.834010000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:50.834 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.834071000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:50.834 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:50.834131000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:51.000 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:51.24000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:51.000 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:51.151000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:51.000 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:51.505000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:51.083 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.83529000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '8dfb9ccc50ac54458bf308b599a295ce' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:51.083 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.83723000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:51.083 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.83760000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:51.083 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.83793000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:51.892 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:51.892358000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:51.892 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:51.892453000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:51.893 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:51.893129000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:51.949 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.949791000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '91f15eeb2a79564b95467163278eea17' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:51.949 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.949974000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:51.950 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.950012000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:51.950 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:51.950053000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: e). Notifying listeners now.
07-26 15:43:52.115 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.115658000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:52.115 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.115705000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:52.115 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.115914000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:52.171 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.171557000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '60e0c32ea0f296448cbf4bf1f457b252' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:52.171 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.171737000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:52.171 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.171766000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:52.171 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.171795000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:52.374 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.374181000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:52.374 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.374276000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:52.375 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.375627000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:52.407 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.407379000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'f66ef0b2144bde4d98d7238d0ff63adc' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:52.407 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.407563000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:52.407 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.407593000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:52.407 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:52.407622000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:52.969 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.969864000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:52.969 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.969965000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:52.970 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:52.970474000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:53.028 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.27975000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'a4567b94b5daa240853e2ce45b4a5dd9' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:53.028 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.28235000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:53.028 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.28281000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:53.028 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.28326000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:53.234 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.234244000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:53.234 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.234390000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:53.235 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.235165000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:53.286 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.285966000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'e62b116d0a7d1c4184d58bd9cb782477' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:53.286 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.286127000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:53.286 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.286155000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:53.286 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.286184000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:53.389 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.389152000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:53.389 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.389214000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:53.394 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.394818000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:53.435 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.435395000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '3b4f84fd12e740438e352862785aa20e' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:53.435 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.435605000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:53.435 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.435641000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:53.435 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.435674000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:53.581 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.581770000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:53.581 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.581869000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:53.582 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.582211000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:53.657 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.656988000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '182781f01265fe49b3bcc3d384e48857' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:53.657 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.657269000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:53.657 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.657321000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:53.657 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.657369000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:53.802 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.802821000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:53.802 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.802873000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:53.803 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:53.803137000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:53.834 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.834849000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'ceb15d1b90c9874e9a3fca88adb4b890' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:53.835 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.835052000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:53.835 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.835082000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:53.835 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:53.835111000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:54.060 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:54.60338000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:54.060 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:54.60469000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:54.067 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:54.66912000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:54.150 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.150265000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '28edddd74ba24440b974f713e37bd1cc' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:54.150 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.150662000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:54.150 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.150787000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:54.150 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.150849000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:54.256 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:54.256579000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:54.256 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:54.256749000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:54.271 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:54.270915000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:54.355 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.355235000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '3476683ed4d89c469fb9ec05b81aac26' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:54.355 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.355571000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:54.355 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.355636000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:54.355 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:54.355807000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:55.241 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.241011000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:55.241 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.241147000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:55.251 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.251321000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:55.333 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.333216000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '48478dae8293ed408a08bf8e2a77ee70' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:55.333 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.333557000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:55.333 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.333650000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:55.333 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.333759000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:55.472 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.472679000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:55.472 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.472737000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:55.472 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.472943000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:55.510 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.510563000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'b081909488a94e4a95479dbe5a3090a7' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:55.510 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.510822000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:55.510 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.510857000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:55.510 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.510887000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:55.843 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.843257000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:55.843 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.843436000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:55.850 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:55.850834000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:55.902 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.902171000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'a7f7fdca4a1f8048a9dad5a1ad1bc88f' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:55.902 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.902402000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:55.902 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.902435000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:55.902 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:55.902472000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:56.772 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:56.772653000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:56.772 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:56.772762000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:56.780 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:56.780886000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:56.867 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:56.867905000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'b251e40b298b5940858b683e12847b39' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:56.868 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:56.868294000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:56.868 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:56.868357000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:56.868 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:56.868421000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:58.384 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:58.384202000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:58.384 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:58.384335000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:58.390 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:58.390875000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:58.494 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.494782000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'c7abe255553b8448acefc305c23fe48c' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:58.495 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.495079000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:58.495 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.495128000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:58.495 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.495176000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:43:58.767 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:58.767105000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:43:58.767 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:58.767229000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:43:58.769 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:43:58.769126000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:43:58.836 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.836209000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '23d892c1dcbc6a43805160d9fd752dce' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:43:58.836 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.836402000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:43:58.836 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.836444000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:43:58.836 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:43:58.836486000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:44:01.214 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:44:1.213992000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-26 15:44:01.214 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:44:1.214085000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-26 15:44:01.214 21927 21942 E test_spatial_anchors: E::[2019.7.26 22:44:1.214405000 UTC][3752651040][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-26 15:44:01.273 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:44:1.273411000 UTC][2984225056][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '47d655574ce4a44e8c757fceeca1348c' was added to the map, bumping out '00000000000000000000000000000000'.
07-26 15:44:01.273 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:44:1.273659000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-26 15:44:01.273 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:44:1.273697000 UTC][2984225056][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-26 15:44:01.273 21927 22084 E test_spatial_anchors: E::[2019.7.26 22:44:1.273735000 UTC][2984225056][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-26 15:44:01.650 21927 22195 E test_spatial_anchors: E::[2019.7.26 22:44:1.650858000 UTC][2773489952][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateForPlatformAnchor] Creating a neighborhood anchor.
07-26 15:44:01.651 21927 22105 E test_spatial_anchors: E::[2019.7.26 22:44:1.651157000 UTC][2963335456][my_session.cpp:439] MS debug message: StoreAndWatcherTrackedState::TryCreateInternalAsync for a new SpatialAnchor.
07-26 15:44:01.651 21927 22105 E test_spatial_anchors: E::[2019.7.26 22:44:1.651214000 UTC][2963335456][my_session.cpp:439] MS debug message: StoreAndWatcherTrackedState::TryCreateWithNewNeighborhoodAnchor
07-26 15:44:01.653 21927 22097 E test_spatial_anchors: E::[2019.7.26 22:44:1.653009000 UTC][2971691296][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetAnchorNeighborhoodDataAsync] Triangulating the keyframes.
07-26 15:44:06.378 21927 22097 E test_spatial_anchors: E::[2019.7.26 22:44:6.378247000 UTC][2971691296][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetAnchorNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-26 15:44:06.379 21927 22097 E test_spatial_anchors: E::[2019.7.26 22:44:6.379171000 UTC][2971691296][my_session.cpp:439] MS debug message: RestClient::CreateNeighborhoodAnchorAndSpatialAnchorAsync - ReqCV: gkzD+fGSRAmuv0fm8tEyEA
07-26 15:44:06.379 21927 22097 E test_spatial_anchors: E::[2019.7.26 22:44:6.379335000 UTC][2971691296][my_session.cpp:439] MS debug message: RestClient::GetAccessTokenAsync - ReqCV: Du+0TvUCSJKm9Wbyz16ckQ
07-26 15:44:07.133 21927 22100 E test_spatial_anchors: E::[2019.7.26 22:44:7.133918000 UTC][2968557856][my_session.cpp:439] MS debug message: N15SpatialServices21GetAccessTokenRequestE returned HTTP 200. ReqCV: Du+0TvUCSJKm9Wbyz16ckQ. RespCV: +BO0UT7JGE2Z8+tfewGMbw.0.
07-26 15:44:08.221 21927 22093 E test_spatial_anchors: E::[2019.7.26 22:44:8.221124000 UTC][2975869216][my_session.cpp:439] MS debug message: N15SpatialServices47CreateNeighborhoodAnchorAndSpatialAnchorRequestE returned HTTP 201. ReqCV: gkzD+fGSRAmuv0fm8tEyEA. RespCV: /6/n0anPrUy1Xi/NV995yQ.0.
07-26 15:44:08.221 21927 22093 E test_spatial_anchors: E::[2019.7.26 22:44:8.221417000 UTC][2975869216][my_session.cpp:439] MS debug message: RestClient::CreateNeighborhoodAnchorAndSpatialAnchorAsync - HTTP Response Status Code: 201
07-26 15:44:08.223 21927 22093 E test_spatial_anchors: E::[2019.7.26 22:44:8.223003000 UTC][2975869216][my_session.cpp:439] MS debug message: StoreAndWatcherTrackedState::CreateNeighborhoodAnchorAndSpatialAnchor for SpatialAnchor 0da5f183-76b8-448e-82de-3f8750842aeb succeeded! Its NeighborhoodAnchorId is 17293e4c-13de-4de5-9e5f-fdfa0b428475, and the IndexNeighborhoodDataId: 2afb03d7-9c9c-44d8-98ae-2df7e7d2f03c

And here are the logs for the anchor query:

07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764655000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Session Identifier: 072b6c33-fd0d-432d-91b3-0d6776e7860d [AUTOMATION]
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764751000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured AnchorServiceUrl: https://manage.sa.mixedreality.azure.com/
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764781000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured AuthServiceUrl: https://sts.mixedreality.azure.com/
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764809000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured AccountId: [removed]
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764835000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured DeviceOsVersion: 8.0.0
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764861000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured SdkPackageType: 
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764886000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured SdkVersion: 1.1.1
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764912000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured ArPlatformVersion: 8.0.0
07-27 06:43:45.764 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.764937000 UTC][3537369456][my_session.cpp:439] MS debug message: AzureSpatialAnchors - Configured MiddlewareVersions: 
07-27 06:43:45.765 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:45.765844000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::MobileNeighborhoodManager] Initialized the mobile neighborhood manager.
07-27 06:43:46.936 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:46.936725000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:46.936 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:46.936814000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:46.938 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:46.938176000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:46.995 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:46.995296000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'a7c4021b3373d5439ab9d97dee08b6f8' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:46.995 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:46.995460000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:46.995 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:46.995491000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:46.995 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:46.995520000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:47.601 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:47.601096000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:47.601 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:47.601328000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:47.616 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:47.616045000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:47.679 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.679534000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '16ddba9341d9de428590b6be1e5f748b' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:47.679 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.679753000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:47.679 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.679813000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:47.679 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.679868000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:47.880 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:47.880438000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:47.880 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:47.880520000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:47.881 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:47.881202000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:47.946 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.946713000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '73f8bb7f12cb7843b0c0e24a17536e23' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:47.946 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.946880000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:47.946 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.946934000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:47.947 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:47.946987000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:48.074 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.74309000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:48.074 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.74411000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:48.075 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.75154000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:48.135 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.135423000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '53b3811ccbcd9c48886f9cf3e56f171d' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:48.135 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.135634000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:48.135 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.135684000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:48.135 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.135731000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:48.398 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.398812000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:48.398 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.398909000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:48.407 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.407141000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:48.485 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.485787000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '7c0b7abd3f90194bb54f3050da9370db' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:48.486 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.486033000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:48.486 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.486100000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:48.486 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:48.486160000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:48.978 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.978510000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:48.978 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.978618000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:48.979 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:48.979385000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:49.057 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.57601000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'e021059ee609b742b154a3a665c60ff2' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:49.057 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.57811000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:49.057 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.57873000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:49.057 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.57935000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:49.143 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.143873000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:49.143 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.143951000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:49.144 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.144457000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:49.217 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.217719000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '5b397b30022fc84e80af335a5d3ebe3c' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:49.217 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.217955000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:49.218 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.218021000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:49.218 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.218082000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:49.338 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.338301000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:49.338 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.338400000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:49.347 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.347127000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:49.404 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.404398000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '650a6d556da0ea4c82e858736086adfa' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:49.404 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.404597000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:49.404 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.404653000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:49.404 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.404706000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:49.512 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.512567000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:49.512 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.512669000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:49.513 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.513305000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:49.604 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.604929000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '6a829cc57e9bfb4dab319fac970a0e9f' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:49.605 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.605142000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:49.605 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.605214000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:49.605 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.605283000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:49.798 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.798290000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:49.798 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.798413000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:49.798 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:49.798791000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:49.879 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.879768000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '951934073e1caf4193c1bea91f129a36' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:49.880 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.880084000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:49.880 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.880145000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:49.880 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:49.880197000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:50.118 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.118612000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:50.118 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.118737000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:50.119 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.119106000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:50.196 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.196011000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '7b844e7e31ab2e4d9b5f953e7847f31f' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:50.196 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.196283000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:50.196 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.196346000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:50.196 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.196406000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:50.347 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.347850000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:50.347 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.347911000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:50.348 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.348151000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:50.413 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.413275000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '754a2752c00fde4f9723765e2ec6fbf9' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:50.413 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.413548000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:50.413 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.413610000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:50.413 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.413665000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:50.711 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.711748000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:50.711 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.711830000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:50.712 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:50.712118000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:50.760 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.760787000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '05f26ae64d695544a852ee4c57fa29d1' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:50.760 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.760969000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:50.761 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.761002000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:50.761 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:50.761033000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:51.000 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:51.358000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:51.000 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:51.459000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:51.000 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:51.943000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:51.077 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.77375000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '05dea0c32e9c2c43a51e6f1cc12c5052' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:51.077 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.77655000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:51.077 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.77717000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:51.077 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.77773000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:51.269 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:51.269672000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:51.269 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:51.269757000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:51.270 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:51.270088000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:51.346 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.346150000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '1a80fef56ad1dc4c8b8ac18418af1724' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:51.346 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.346403000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:51.346 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.346464000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:51.346 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:51.346522000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:52.117 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.117572000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:52.117 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.117672000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:52.118 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.118437000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:52.199 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.199815000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'd273760cb1a97348ae4b71edab4bee49' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:52.200 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.200113000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:52.200 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.200175000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:52.200 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.200233000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:52.330 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.330722000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:52.330 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.330845000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:52.331 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.331290000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:52.431 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.431517000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'be9dab0e07dc7b449a74134679b1059a' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:52.431 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.431836000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:52.431 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.431908000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:52.432 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.431974000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:52.622 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.622185000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:52.622 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.622304000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:52.622 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:52.622724000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:52.696 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.696158000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'd672096d37f3dc488881513892512510' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:52.696 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.696365000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:52.696 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.696411000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:52.696 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:52.696452000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:53.374 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.374638000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:53.374 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.374736000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:53.375 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.375333000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:53.470 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.470137000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '8241e8d87ffccd4c8c24488a798ce9cd' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:53.470 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.470433000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:53.470 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.470496000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:53.470 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.470555000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:53.573 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.573118000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:53.573 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.573216000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:53.573 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.573540000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:53.647 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.647840000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '60bd406bc616ac4ca5972d102e34097d' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:53.648 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.648156000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:53.648 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.648224000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:53.648 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.648290000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: e). Notifying listeners now.
07-27 06:43:53.737 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.737546000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:53.737 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.737710000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:53.738 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.738136000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:53.818 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.818227000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'c3e1623d6f89a741a8014d248b218f9d' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:53.818 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.818502000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:53.818 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.818567000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:53.818 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:53.818629000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:53.937 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.937821000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:53.937 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.937950000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:53.938 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:53.938287000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:54.017 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.17756000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '0b627d2ec6ecec4bbc826e3a6a597e04' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:54.018 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.18041000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:54.018 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.18104000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:54.018 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.18184000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:54.193 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:54.193343000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:54.193 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:54.193468000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:54.193 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:54.193875000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:54.260 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.260799000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'eb6156bc2d46c94e927d6c7bb08791d3' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:54.261 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.261085000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:54.261 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.261137000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:54.261 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.261183000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:54.435 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:54.435824000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:54.435 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:54.435949000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:54.436 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:54.436373000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:54.514 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.513966000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '5624a2cc27578c44a3c4f9fe403a8a96' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:54.514 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.514313000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:54.514 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.514374000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:54.514 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:54.514431000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:55.401 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.401435000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:55.401 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.401564000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:55.412 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.412211000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:55.493 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.493602000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '2ce619ac0745c641b1ca5b52b40864d1' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:55.493 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.493895000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:55.493 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.493953000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:55.494 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.494007000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:55.632 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.632489000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:55.632 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.632614000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:55.633 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.632985000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:55.719 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.719793000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'dda60d0c5749b94496d35bb2523dd25a' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:55.720 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.720145000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:55.720 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.720207000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:55.720 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:55.720264000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:55.967 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.967749000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:55.967 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.967867000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:55.977 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:55.977310000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:56.053 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.53760000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '39bd7094a6c9c144a5c3e612bceab663' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:56.054 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.54083000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:56.054 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.54149000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:56.054 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.54208000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:43:56.911 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:56.911310000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:43:56.911 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:56.911441000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:43:56.911 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:43:56.911831000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:43:56.988 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.988259000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '851987c49c92b2439bbeb90a4957dc8e' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:43:56.988 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.988578000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:43:56.988 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.988615000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:43:56.988 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:43:56.988650000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:05.509 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:5.509349000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:05.509 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:5.509454000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:05.509 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:5.509812000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:05.602 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.602248000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '0f3ecd0a099c304289de5ef7db27699f' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:05.602 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.602660000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:05.602 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.602723000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:05.602 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.602784000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:05.693 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:5.693612000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:05.693 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:5.693703000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:05.694 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:5.693980000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:05.768 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.768664000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '07fc7d1fdc9cac40b1a00228474aaf36' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:05.769 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.769134000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:05.769 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.769203000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:05.769 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:5.769265000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:08.625 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:8.625043000 UTC][3537369456][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:08.627 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:8.627666000 UTC][3149982064][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:08.630 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:8.630864000 UTC][3149982064][my_session.cpp:439] MS debug message: RunDiscoverAsync - Creating new Pose Query Processor Stream
07-27 06:44:08.636 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:8.636224000 UTC][3149982064][my_session.cpp:439] MS debug message: RestClient::GetAccessTokenAsync - ReqCV: /E6T5mWGSHuCFPAQSwdXgg
07-27 06:44:08.636 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:8.636504000 UTC][3149982064][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 0. Cached SpatialAnchors: 0.
07-27 06:44:08.636 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:8.636768000 UTC][3146873200][my_session.cpp:439] MS debug message: GetPropertiesAndCVladsForDesiredSpatialAnchorIdsAsync - SetDesiredSpatialAnchors count SA Id[1] NA Id[0], locate strategy[0]
07-27 06:44:08.636 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:8.636938000 UTC][3146873200][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::ClearImageSignaturesForNeighborhoodAnchors] - Count[0]
07-27 06:44:08.637 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:8.637420000 UTC][3145836912][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:08.637 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:8.637582000 UTC][3145836912][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Created cached query root id[1], sending known poses count[0]
07-27 06:44:08.637 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:8.637665000 UTC][3145836912][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:08.691 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:8.691605000 UTC][3145836912][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:08.692 29697 30778 E test_spatial_anchors: E::[2019.7.26 22:44:8.692323000 UTC][3206588784][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:08.692 29697 30778 E test_spatial_anchors: E::[2019.7.26 22:44:8.692410000 UTC][3206588784][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:08.692 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:8.692811000 UTC][3145836912][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[764171]
07-27 06:44:08.693 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:8.692966000 UTC][3207625072][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:08.693 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:8.693097000 UTC][3207625072][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:09.345 29697 30786 E test_spatial_anchors: E::[2019.7.26 22:44:9.338366000 UTC][3213875568][my_session.cpp:439] MS debug message: N15SpatialServices21GetAccessTokenRequestE returned HTTP 200. ReqCV: /E6T5mWGSHuCFPAQSwdXgg. RespCV: 6D/BKucpZ0aeo8Ah/7ic6A.0.
07-27 06:44:09.346 29697 30783 E test_spatial_anchors: E::[2019.7.26 22:44:9.346387000 UTC][3169671536][my_session.cpp:439] MS debug message: PoseQueryProcessorStream - ReqCV: hYZ5IwWvRu+PERV0O00byw
07-27 06:44:11.552 29697 30802 E test_spatial_anchors: E::[2019.7.26 22:44:11.552554000 UTC][3151018352][my_session.cpp:439] MS debug message: PoseQueryProcessorStream - ResCV: 31ipNfRlDUWD9NEGNbMEkA.0
07-27 06:44:11.553 29697 30802 E test_spatial_anchors: E::[2019.7.26 22:44:11.553076000 UTC][3151018352][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:11.553 29697 30802 E test_spatial_anchors: E::[2019.7.26 22:44:11.553195000 UTC][3151018352][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPropertiesEvent - [0da5f183-76b8-448e-82de-3f8750842aeb] was found. naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:11.553 29697 30802 E test_spatial_anchors: E::[2019.7.26 22:44:11.553285000 UTC][3151018352][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:11.553 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:11.553673000 UTC][3138550128][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:11.553 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:11.553917000 UTC][3138550128][my_session.cpp:439] MS debug message: StoreAndWatcherTrackedState::ProcessCompactImageSignatureEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], hasFilter[0xe6169e0c]
07-27 06:44:11.554 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:11.554095000 UTC][3138550128][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SetCompactImageSignatureForNeighborhoodAnchor] 17293e4c-13de-4de5-9e5f-fdfa0b428475 : 36 bytes threshold 0.100000.
07-27 06:44:11.554 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:11.554368000 UTC][3138550128][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:11.556 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:11.556663000 UTC][3166562672][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:11.556 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:11.556827000 UTC][3166562672][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:12.463 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:12.463595000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:12.463 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:12.463701000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:12.464 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:12.464110000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:12.464 29697 30786 E test_spatial_anchors: E::[2019.7.26 22:44:12.464930000 UTC][3213875568][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:12.465 29697 30786 E test_spatial_anchors: E::[2019.7.26 22:44:12.465012000 UTC][3213875568][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:12.549 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:12.549555000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'a265afd514b8a144830fe42ea564c205' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:12.550 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:12.550212000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:12.550 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:12.550289000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:12.550 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:12.550350000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:12.551 29697 30783 E test_spatial_anchors: E::[2019.7.26 22:44:12.551088000 UTC][3169671536][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:12.551 29697 30783 E test_spatial_anchors: E::[2019.7.26 22:44:12.551163000 UTC][3169671536][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:13.850 29697 30790 E test_spatial_anchors: E::[2019.7.26 22:44:13.850492000 UTC][3163453808][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:13.850 29697 30790 E test_spatial_anchors: E::[2019.7.26 22:44:13.850886000 UTC][3163453808][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:13.851 29697 30790 E test_spatial_anchors: E::[2019.7.26 22:44:13.851094000 UTC][3163453808][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:13.851 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:13.851447000 UTC][3157236080][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:13.851 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:13.851621000 UTC][3157236080][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:13.851 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:13.851690000 UTC][3157236080][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:13.852 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:13.852119000 UTC][3136477552][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:13.853 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:13.853752000 UTC][3136477552][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:13.854 29697 30784 E test_spatial_anchors: E::[2019.7.26 22:44:13.854255000 UTC][3168635248][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:13.854 29697 30784 E test_spatial_anchors: E::[2019.7.26 22:44:13.854584000 UTC][3168635248][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:13.858 29697 30801 E test_spatial_anchors: E::[2019.7.26 22:44:13.858705000 UTC][3152054640][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: true [AUTOMATION]
07-27 06:44:13.891 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:13.891638000 UTC][3165526384][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:13.891 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:13.891888000 UTC][3165526384][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:13.897 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:13.897412000 UTC][3165526384][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[789656]
07-27 06:44:13.897 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:13.897557000 UTC][3165526384][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:13.897 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:13.897597000 UTC][3165526384][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:14.491 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:14.491806000 UTC][3149982064][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:14.492 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:14.491898000 UTC][3149982064][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:15.675 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:15.675230000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:15.675 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:15.675412000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:15.675 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:15.675785000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:15.676 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:15.676135000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:15.676 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:15.676554000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:15.676 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:15.676655000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:15.677 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:15.676983000 UTC][3137513840][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:15.677 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:15.677161000 UTC][3137513840][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: false [AUTOMATION]
07-27 06:44:18.131 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:18.131683000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:18.131 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:18.131789000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:18.132 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:18.132238000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:18.133 29697 30798 E test_spatial_anchors: E::[2019.7.26 22:44:18.133139000 UTC][3155163504][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:18.133 29697 30798 E test_spatial_anchors: E::[2019.7.26 22:44:18.133342000 UTC][3155163504][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:18.209 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:18.209858000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '7a2c3dc0b6b9b741ba67cc544eabb32f' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:18.210 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:18.210491000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:18.210 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:18.210596000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:18.210 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:18.210659000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:18.212 29697 30797 E test_spatial_anchors: E::[2019.7.26 22:44:18.212163000 UTC][3156199792][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:18.212 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:18.212493000 UTC][3148945776][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:18.214 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:18.214030000 UTC][3148945776][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:18.214 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:18.214472000 UTC][3148945776][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:18.214 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:18.214595000 UTC][3148945776][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:18.258 29697 30779 E test_spatial_anchors: E::[2019.7.26 22:44:18.258716000 UTC][3205552496][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:18.259 29697 30779 E test_spatial_anchors: E::[2019.7.26 22:44:18.259064000 UTC][3205552496][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:18.266 29697 30779 E test_spatial_anchors: E::[2019.7.26 22:44:18.266230000 UTC][3205552496][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[815141]
07-27 06:44:18.266 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:18.266407000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:18.266 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:18.266500000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:20.187 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:20.171018000 UTC][3153090928][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:20.187 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:20.187705000 UTC][3153090928][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:20.220 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:20.219951000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:20.220 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:20.220094000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:20.220 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:20.220783000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:20.222 29697 30813 E test_spatial_anchors: E::[2019.7.26 22:44:20.221716000 UTC][3139586416][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:20.222 29697 30813 E test_spatial_anchors: E::[2019.7.26 22:44:20.222108000 UTC][3139586416][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:20.288 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:20.288554000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'f1a40c947d4377418e89bb14cf70f8dc' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:20.289 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:20.288994000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:20.289 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:20.289041000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:20.289 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:20.289081000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:20.289 29697 30781 E test_spatial_anchors: E::[2019.7.26 22:44:20.289558000 UTC][3171744112][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:20.289 29697 30781 E test_spatial_anchors: E::[2019.7.26 22:44:20.289744000 UTC][3171744112][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:20.783 29697 30791 E test_spatial_anchors: E::[2019.7.26 22:44:20.783082000 UTC][3162417520][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:20.783 29697 30791 E test_spatial_anchors: E::[2019.7.26 22:44:20.783586000 UTC][3162417520][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:20.783 29697 30791 E test_spatial_anchors: E::[2019.7.26 22:44:20.783830000 UTC][3162417520][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:20.785 29697 30789 E test_spatial_anchors: E::[2019.7.26 22:44:20.784934000 UTC][3164490096][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:20.785 29697 30789 E test_spatial_anchors: E::[2019.7.26 22:44:20.785517000 UTC][3164490096][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:20.785 29697 30789 E test_spatial_anchors: E::[2019.7.26 22:44:20.785621000 UTC][3164490096][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:20.786 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:20.786385000 UTC][3149982064][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:20.786 29697 30810 E test_spatial_anchors: E::[2019.7.26 22:44:20.786281000 UTC][3142695280][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: true [AUTOMATION]
07-27 06:44:20.788 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:20.788012000 UTC][3149982064][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:20.788 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:20.788494000 UTC][3145836912][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:20.788 29697 30807 E test_spatial_anchors: E::[2019.7.26 22:44:20.788660000 UTC][3145836912][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:20.835 29697 30813 E test_spatial_anchors: E::[2019.7.26 22:44:20.834931000 UTC][3139586416][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:20.835 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:20.835332000 UTC][3137513840][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:20.844 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:20.844621000 UTC][3137513840][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[840626]
07-27 06:44:20.844 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:20.844815000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:20.844 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:20.844884000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:21.071 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:21.71599000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:21.071 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:21.71712000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:21.072 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:21.72058000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:21.147 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:21.147083000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'b4ef5a6e51b7884fb41b3d2ddc8d4cbc' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:21.147 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:21.147594000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:21.147 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:21.147663000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:21.147 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:21.147723000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:21.148 29697 30791 E test_spatial_anchors: E::[2019.7.26 22:44:21.148223000 UTC][3162417520][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:21.148 29697 30791 E test_spatial_anchors: E::[2019.7.26 22:44:21.148391000 UTC][3162417520][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:23.088 29697 30798 E test_spatial_anchors: E::[2019.7.26 22:44:23.88106000 UTC][3155163504][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:23.088 29697 30798 E test_spatial_anchors: E::[2019.7.26 22:44:23.88204000 UTC][3155163504][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:23.175 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:23.175674000 UTC][3166562672][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:23.176 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:23.176221000 UTC][3166562672][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:23.176 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:23.176483000 UTC][3166562672][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:23.177 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:23.177542000 UTC][3148945776][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:23.177 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:23.177679000 UTC][3148945776][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:23.177 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:23.177809000 UTC][3148945776][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:23.178 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:23.178181000 UTC][3148945776][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: true [AUTOMATION]
07-27 06:44:23.178 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.178228000 UTC][3170707824][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:23.180 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.180007000 UTC][3170707824][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:23.180 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.180453000 UTC][3170707824][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:23.180 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.180572000 UTC][3170707824][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:23.248 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.248805000 UTC][3170707824][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:23.249 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.249652000 UTC][3170707824][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:23.249 29697 30790 E test_spatial_anchors: E::[2019.7.26 22:44:23.249922000 UTC][3163453808][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:23.250 29697 30790 E test_spatial_anchors: E::[2019.7.26 22:44:23.250006000 UTC][3163453808][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:23.262 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:23.262189000 UTC][3170707824][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[866111]
07-27 06:44:23.262 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:23.262491000 UTC][3159308656][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:23.262 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:23.262847000 UTC][3159308656][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:25.780 29697 30792 E test_spatial_anchors: E::[2019.7.26 22:44:25.780245000 UTC][3161381232][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:25.780 29697 30792 E test_spatial_anchors: E::[2019.7.26 22:44:25.780849000 UTC][3161381232][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:25.781 29697 30792 E test_spatial_anchors: E::[2019.7.26 22:44:25.781232000 UTC][3161381232][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:25.781 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:25.781867000 UTC][3149982064][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:25.782 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:25.782011000 UTC][3149982064][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:25.782 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:25.782128000 UTC][3149982064][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:25.782 29697 30802 E test_spatial_anchors: E::[2019.7.26 22:44:25.782482000 UTC][3151018352][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:25.782 29697 30802 E test_spatial_anchors: E::[2019.7.26 22:44:25.782627000 UTC][3151018352][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: false [AUTOMATION]
07-27 06:44:30.365 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:30.365406000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:30.365 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:30.365508000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:30.365 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:30.365844000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:30.366 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:30.366634000 UTC][3165526384][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:30.366 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:30.366711000 UTC][3165526384][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:30.435 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.435136000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '0e3b3862b117f140bae0ec099c9c1c87' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:30.436 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.436032000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:30.436 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.436110000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:30.436 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.436172000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:30.436 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:30.436878000 UTC][3166562672][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:30.437 29697 30797 E test_spatial_anchors: E::[2019.7.26 22:44:30.437184000 UTC][3156199792][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:30.438 29697 30797 E test_spatial_anchors: E::[2019.7.26 22:44:30.438953000 UTC][3156199792][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:30.439 29697 30779 E test_spatial_anchors: E::[2019.7.26 22:44:30.439460000 UTC][3205552496][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:30.439 29697 30779 E test_spatial_anchors: E::[2019.7.26 22:44:30.439578000 UTC][3205552496][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:30.485 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:30.485110000 UTC][3146873200][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:30.485 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:30.485466000 UTC][3146873200][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:30.497 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:30.497377000 UTC][3146873200][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[891596]
07-27 06:44:30.499 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:30.499620000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:30.499 29697 30806 E test_spatial_anchors: E::[2019.7.26 22:44:30.499756000 UTC][3146873200][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:30.884 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:30.884162000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:30.884 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:30.884308000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:30.886 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:30.886750000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:30.940 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.940102000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'faa06236a55bb74aa6f47d367bd828ce' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:30.940 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.940518000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:30.940 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.940585000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:30.940 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:30.940632000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:30.952 29697 30789 E test_spatial_anchors: E::[2019.7.26 22:44:30.952221000 UTC][3164490096][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:30.952 29697 30789 E test_spatial_anchors: E::[2019.7.26 22:44:30.952302000 UTC][3164490096][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:31.204 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.204828000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:31.204 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.204948000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:31.205 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.205343000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:31.277 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.277523000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '686137569c1de340be7df7141eae6bb8' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:31.278 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.278094000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:31.278 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.278166000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:31.278 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.278226000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:31.279 29697 30795 E test_spatial_anchors: E::[2019.7.26 22:44:31.279270000 UTC][3158272368][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:31.279 29697 30795 E test_spatial_anchors: E::[2019.7.26 22:44:31.279514000 UTC][3158272368][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:31.469 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.469871000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:31.470 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.469983000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:31.477 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.477233000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:31.550 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.550743000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '777bc00a8f34cb48bacdd6c10e19e8dd' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:31.551 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.551665000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:31.551 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.551757000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:31.551 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.551825000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:31.552 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:31.552480000 UTC][3153090928][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:31.552 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:31.552559000 UTC][3153090928][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:31.892 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.892380000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:31.892 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.892509000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:31.907 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:31.907148000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:31.984 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.984187000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '928721e858229847b6a3cc64418e6b70' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:31.985 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.985064000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:31.985 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.985146000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:31.985 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:31.985214000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:31.986 29697 30817 E test_spatial_anchors: E::[2019.7.26 22:44:31.986137000 UTC][3135441264][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:31.986 29697 30817 E test_spatial_anchors: E::[2019.7.26 22:44:31.986396000 UTC][3135441264][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:32.220 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:32.220233000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:32.220 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:32.220372000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:32.220 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:32.220764000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:32.312 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:32.312445000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'f8957a140f2a6e4385bd72e8969c3be1' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:32.313 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:32.313035000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:32.313 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:32.313110000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:32.313 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:32.313176000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:32.313 29697 30781 E test_spatial_anchors: E::[2019.7.26 22:44:32.313755000 UTC][3171744112][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:32.313 29697 30781 E test_spatial_anchors: E::[2019.7.26 22:44:32.313826000 UTC][3171744112][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:32.985 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:32.985341000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:32.985 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:32.985595000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:32.986 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:32.986079000 UTC][3137513840][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:32.986 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:32.986426000 UTC][3136477552][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:32.986 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:32.986567000 UTC][3136477552][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:32.986 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:32.986676000 UTC][3136477552][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:32.987 29697 30813 E test_spatial_anchors: E::[2019.7.26 22:44:32.987142000 UTC][3139586416][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: true [AUTOMATION]
07-27 06:44:32.987 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:32.987214000 UTC][3159308656][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:32.989 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:32.989820000 UTC][3159308656][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:32.990 29697 30799 E test_spatial_anchors: E::[2019.7.26 22:44:32.990321000 UTC][3154127216][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:32.990 29697 30799 E test_spatial_anchors: E::[2019.7.26 22:44:32.990731000 UTC][3154127216][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:33.056 29697 30817 E test_spatial_anchors: E::[2019.7.26 22:44:33.56403000 UTC][3135441264][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:33.057 29697 30780 E test_spatial_anchors: E::[2019.7.26 22:44:33.56709000 UTC][3200514416][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:33.067 29697 30780 E test_spatial_anchors: E::[2019.7.26 22:44:33.67668000 UTC][3200514416][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[1019021]
07-27 06:44:33.067 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:33.67922000 UTC][3157236080][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:33.068 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:33.68005000 UTC][3157236080][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:34.224 29697 30808 E test_spatial_anchors: E::[2019.7.26 22:44:34.224211000 UTC][3143731568][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:34.224 29697 30808 E test_spatial_anchors: E::[2019.7.26 22:44:34.224583000 UTC][3143731568][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:35.938 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:35.938671000 UTC][3170707824][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:35.938 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:35.938908000 UTC][3170707824][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:35.939 29697 30782 E test_spatial_anchors: E::[2019.7.26 22:44:35.939152000 UTC][3170707824][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:35.940 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:35.940863000 UTC][3148945776][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:35.941 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:35.941058000 UTC][3148945776][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:35.941 29697 30804 E test_spatial_anchors: E::[2019.7.26 22:44:35.941176000 UTC][3148945776][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:35.942 29697 30805 E test_spatial_anchors: E::[2019.7.26 22:44:35.941829000 UTC][3147909488][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:35.942 29697 30805 E test_spatial_anchors: E::[2019.7.26 22:44:35.942355000 UTC][3147909488][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: false [AUTOMATION]
07-27 06:44:38.285 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.285261000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:38.285 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.285405000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:38.286 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.286068000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:38.287 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:38.287143000 UTC][3157236080][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:38.287 29697 30796 E test_spatial_anchors: E::[2019.7.26 22:44:38.287283000 UTC][3157236080][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:38.363 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.363299000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'd119b9e59753aa4191556785359c884f' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:38.364 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.363964000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:38.364 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.364067000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:38.364 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.364137000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:38.364 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:38.364777000 UTC][3137513840][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:38.365 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:38.365017000 UTC][3137513840][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:38.366 29697 30815 E test_spatial_anchors: E::[2019.7.26 22:44:38.366531000 UTC][3137513840][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:38.367 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.367056000 UTC][3165526384][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:38.367 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.367220000 UTC][3165526384][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:38.426 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.426849000 UTC][3165526384][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:38.427 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.427289000 UTC][3165526384][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:38.436 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.436636000 UTC][3165526384][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[1044506]
07-27 06:44:38.436 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.436823000 UTC][3165526384][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:38.436 29697 30788 E test_spatial_anchors: E::[2019.7.26 22:44:38.436895000 UTC][3165526384][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:38.486 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.486188000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:38.486 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.486300000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:38.486 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.486614000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:38.557 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.557561000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'be4abdbacb14c942947ee5d69af9f7c1' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:38.558 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.558344000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:38.558 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.558434000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:38.558 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.558503000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:38.559 29697 30812 E test_spatial_anchors: E::[2019.7.26 22:44:38.559248000 UTC][3140622704][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:38.559 29697 30812 E test_spatial_anchors: E::[2019.7.26 22:44:38.559542000 UTC][3140622704][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:38.754 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.754202000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:38.754 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.754345000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:38.754 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:38.754694000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:38.823 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.823682000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'cd37dc68297e5e4091022ef0ce3897cc' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:38.824 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.824207000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Query Added to Blob Builder [AUTOMATION]
07-27 06:44:38.824 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.824270000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:38.824 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:38.824322000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: a). Notifying listeners now.
07-27 06:44:38.824 29697 30805 E test_spatial_anchors: E::[2019.7.26 22:44:38.824948000 UTC][3147909488][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:38.825 29697 30805 E test_spatial_anchors: E::[2019.7.26 22:44:38.825014000 UTC][3147909488][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:40.766 29697 30813 E test_spatial_anchors: E::[2019.7.26 22:44:40.766182000 UTC][3139586416][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 1
07-27 06:44:40.766 29697 30813 E test_spatial_anchors: E::[2019.7.26 22:44:40.766283000 UTC][3139586416][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:41.804 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:41.804763000 UTC][3159308656][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:41.805 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:41.805226000 UTC][3159308656][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:41.805 29697 30794 E test_spatial_anchors: E::[2019.7.26 22:44:41.805513000 UTC][3159308656][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:41.806 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:41.805959000 UTC][3138550128][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:41.806 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:41.806137000 UTC][3138550128][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:41.806 29697 30814 E test_spatial_anchors: E::[2019.7.26 22:44:41.806285000 UTC][3138550128][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:41.806 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:41.806876000 UTC][3153090928][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: true [AUTOMATION]
07-27 06:44:41.807 29697 30797 E test_spatial_anchors: E::[2019.7.26 22:44:41.807097000 UTC][3156199792][my_session.cpp:439] MS debug message: RunDiscoverAsync - Running a Discover iteration with 1 DiscoverOptions
07-27 06:44:41.809 29697 30797 E test_spatial_anchors: E::[2019.7.26 22:44:41.809478000 UTC][3156199792][my_session.cpp:439] MS debug message: RunDiscoverAsync - Snapshot - Counts of Cached NeighborhoodAnchors: 1. Cached SpatialAnchors: 1.
07-27 06:44:41.810 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.810026000 UTC][3207625072][my_session.cpp:439] MS debug message: EnsureQueryRootKnownPosesAndBlobForStreamingQuery - Reusing cached query root id[1]
07-27 06:44:41.810 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.810220000 UTC][3207625072][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::CreateAtCurrentLocation] Creating a neighborhood anchor.
07-27 06:44:41.875 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.875808000 UTC][3207625072][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::GetQueryNeighborhoodDataAsync] IsNeighborhoodDataAvailable: 1, Feedback: 0.
07-27 06:44:41.876 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.876331000 UTC][3207625072][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - blob filter match naid[17293e4c-13de-4de5-9e5f-fdfa0b428475]
07-27 06:44:41.876 29697 30799 E test_spatial_anchors: E::[2019.7.26 22:44:41.876824000 UTC][3154127216][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:41.876 29697 30799 E test_spatial_anchors: E::[2019.7.26 22:44:41.876902000 UTC][3154127216][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:41.879 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.879688000 UTC][3207625072][my_session.cpp:439] MS debug message: RunStreamingVisualPoseQueryForNotYetLocalizedNeighborhoodAnchorIdsAsync - AddKeyFrameBlobQuery of bytes[1095476]
07-27 06:44:41.879 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.879956000 UTC][3207625072][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:41.880 29697 30777 E test_spatial_anchors: E::[2019.7.26 22:44:41.880035000 UTC][3207625072][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:44.891 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:44.891752000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:44.891 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:44.891865000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:44.892 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:44.892548000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:44.893 29697 30778 E test_spatial_anchors: E::[2019.7.26 22:44:44.893347000 UTC][3206588784][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:44.893 29697 30778 E test_spatial_anchors: E::[2019.7.26 22:44:44.893456000 UTC][3206588784][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:44.951 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:44.951051000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '0a7f52325e5f314c85c5eea8c7821da6' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:44.951 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:44.951676000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:44.951 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:44.951762000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: 2). Notifying listeners now.
07-27 06:44:44.952 29697 30792 E test_spatial_anchors: E::[2019.7.26 22:44:44.952395000 UTC][3161381232][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:44.952 29697 30792 E test_spatial_anchors: E::[2019.7.26 22:44:44.952476000 UTC][3161381232][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:45.257 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.257814000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:45.258 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.257970000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:45.258 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.258679000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:45.339 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:45.339200000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '1697c9ca4eface4f95703d6a9ae5cac7' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:45.339 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:45.339879000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:45.340 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:45.339971000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: 2). Notifying listeners now.
07-27 06:44:45.340 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:45.340811000 UTC][3136477552][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:45.340 29697 30816 E test_spatial_anchors: E::[2019.7.26 22:44:45.340919000 UTC][3136477552][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because locate is already underway
07-27 06:44:45.355 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:45.355563000 UTC][3153090928][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:45.355 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:45.355795000 UTC][3153090928][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingPoseEvent - naid[17293e4c-13de-4de5-9e5f-fdfa0b428475], wasRelocalized[0].
07-27 06:44:45.356 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:45.356047000 UTC][3153090928][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - Awaiting more stream events
07-27 06:44:45.356 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:45.356177000 UTC][3153090928][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - entry
07-27 06:44:45.356 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:45.356254000 UTC][3153090928][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEvents - Received KeyFrameProcessingComplete event.
07-27 06:44:45.356 29697 30800 E test_spatial_anchors: E::[2019.7.26 22:44:45.356321000 UTC][3153090928][my_session.cpp:439] MS debug message: ProcessPoseQueryStreamingEventsUntilCompletion - DiscoverComplete successfully.
07-27 06:44:45.356 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:45.356645000 UTC][3149982064][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:45.356 29697 30803 E test_spatial_anchors: E::[2019.7.26 22:44:45.356732000 UTC][3149982064][my_session.cpp:439] MS debug message: Watcher 1 finished operation, starting another: false [AUTOMATION]
07-27 06:44:45.588 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.588186000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:45.588 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.588329000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:45.597 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.597144000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:45.657 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:45.657084000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate 'b1c0359ec14fda48a6ee106a83858076' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:45.657 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:45.657765000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:45.657 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:45.657851000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: 2). Notifying listeners now.
07-27 06:44:45.658 29697 30780 E test_spatial_anchors: E::[2019.7.26 22:44:45.658477000 UTC][3200514416][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:45.658 29697 30780 E test_spatial_anchors: E::[2019.7.26 22:44:45.658554000 UTC][3200514416][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
07-27 06:44:45.993 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.993858000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::IsCandidateKeyFrameRedundant] No, so we will enqueue this frame for further processing...
07-27 06:44:45.994 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.994028000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] No pixel data in current frame, so making a request for that in subsequent frame.
07-27 06:44:45.994 29697 29732 E test_spatial_anchors: E::[2019.7.26 22:44:45.994266000 UTC][3537369456][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::OnArFrameAvailable] Queueing the frame for keyframe creation - Queue-count: 1, running?=1 at-work?=0
07-27 06:44:46.028 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:46.28696000 UTC][3208661360][my_session.cpp:439] MS debug message: [MobileNeighborhoodManager::SelectAndProcessNextAvailableMobileArFrame] Candidate '86138253a04b2a49b823fc683c2bb7be' was added to the map, bumping out '00000000000000000000000000000000'.
07-27 06:44:46.029 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:46.29164000 UTC][3208661360][my_session.cpp:439] MS debug message: Key-Frame for Create Added to Blob Builder [AUTOMATION]
07-27 06:44:46.029 29697 30776 E test_spatial_anchors: E::[2019.7.26 22:44:46.29235000 UTC][3208661360][my_session.cpp:439] MS debug message: [SelectAndProcessNextAvailableMobileArFrame] Create or query sufficiency status hash changed (notificationMask: 2). Notifying listeners now.
07-27 06:44:46.029 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:46.29650000 UTC][3166562672][my_session.cpp:439] MS debug message: [HandleFeedbackUpdated] Progress for locate was made since last request: 0
07-27 06:44:46.029 29697 30787 E test_spatial_anchors: E::[2019.7.26 22:44:46.29708000 UTC][3166562672][my_session.cpp:439] MS debug message: [ConsiderFiringLocate] Will not locate because no progress has been made since last request
JaimeIvanCervantes commented 5 years ago

After I updated to 1.3.0 the NDK demo is still not working; I am not even seeing LocateAnchorStatus::NotLocated anymore, there are still no error messages, and I still see wasRelocalized[0]. I still see the anchor ID being found though:

ProcessPoseQueryStreamingPropertiesEvent - [4aa25fbe-4c26-41b0-b2e7-69b70543d981] was found. naid[72b2bd58-2d53-454f-b5c7-ee2f653a06e1]

And I also see a new debug message that I didn't see before update 1.3.0:

OnArFrameAvailable - CalculateSpeeds failed; speed data should not be trusted.

This message appears very often (probably for every frame?) and it floods my logs.

RamonArguelles commented 5 years ago

Hi @JaimeIvanCervantes,

Are you still seeing this issue? If so, a few questions:

Thanks!

no-response[bot] commented 4 years ago

This issue has been automatically closed because there has been no response to our request for more information from the original author. With only the information that is currently in the issue, we don't have enough information to take action. Please reach out if you have or find the answers we need so that we can investigate further.