Hangs Getting Metadata when Adding Items to Both Collection and Catalog

[Kirk Baker]

Mark,

fwiw, here's another instance (I wont send any more unless it's significantly different)

On the next one, can you note the time of the following:

1) Time of the hang occurring.
2) Time when you clicked on the Abort button
3) Time that you Force Quit the app

Thanks,

-Kirk
 

[guang]

Kirk,

Ok the freeze occurred at 9:37pm.  Attempt to abort also at 9:37, about 15 seconds later.  Force quit at 9:38.

The freezes seem to happen more regularly now, almost every time I try to move files in and out of catalogs and collections.

best
Mark

[Kirk Baker]

Mark,

Ok the freeze occurred at 9:37pm.  Attempt to abort also at 9:37, about 15 seconds later.  Force quit at 9:38.

The freezes seem to happen more regularly now, almost every time I try to move files in and out of catalogs and collections.

Here is what is in the log at 9:37PM:

[Mon Aug-30-2021 21:37:15.424][10d4705c0][5804620] DocumentMetadataPreload.cpp:264 DocumentMetadataPreload::PreloadDocumentItems() called by AddPhotosToCatalog::AddCommon()
[Mon Aug-30-2021 21:37:15.425][10d4705c0][5804620] DocumentMetadataPreload.cpp:268 DocumentMetadataPreload::PreloadDocumentItems() processing single cell
[Mon Aug-30-2021 21:37:15.431][10d4705c0][5804620] DocumentMetadataPreload.cpp:273 DocumentMetadataPreload::PreloadDocumentItems() processing single cell
[Mon Aug-30-2021 21:37:15.431][10d4705c0][5804620] DocumentMetadataPreload.cpp:275 DocumentMetadataPreload::PreloadDocumentItems() no preload needed for single cell, not a standin
[Mon Aug-30-2021 21:37:15.431][10d4705c0][5804620] DocumentMetadataPreload.cpp:288 DocumentMetadataPreload::PreloadDocumentItems() adding item, local:yes, local_remote:no
[Mon Aug-30-2021 21:37:15.431][10d4705c0][5804620] DocumentMetadataPreload.cpp:309 DocumentMetadataPreload::PreloadDocumentItems() no preload needed, calling filter for all items.
[Mon Aug-30-2021 21:37:15.431][10d4705c0][5804620] DocumentMetadataPreload.cpp:313 DocumentMetadataPreload::PreloadDocumentItems() filtering completed.
[Mon Aug-30-2021 21:37:15.432][10d4705c0][5804620] DocumentMetadataPreload.cpp:317 DocumentMetadataPreload::PreloadDocumentItems() completed, returning result: 0 to AddPhotosToCatalog::AddCommon()
[Mon Aug-30-2021 21:37:17.617][7000116fd000][5808424] [TIMING] AddPhotosToCatalogWorker::append_rec() iip->Serialize() [1] 0.000163
[Mon Aug-30-2021 21:37:17.618][7000116fd000][5808424] [TIMING] AddPhotosToCatalogWorker::DoWork() add item 0.000460
[Mon Aug-30-2021 21:37:17.624][7000116fd000][5808424] [TIMING] AddPhotosToCatalogWorker::DoWork() add batch 0.006427
[Mon Aug-30-2021 21:37:17.674][7000116fd000][5808312] [TIMING] AddPhotosToCatalogWorker::DoWork() send batch 0.050105
[Mon Aug-30-2021 21:37:17.674][7000116fd000][5808312] [TIMING] AddPhotosToCatalogWorker::DoWork() 0.056873
[Mon Aug-30-2021 21:37:17.724][10d4705c0][5800184] AddPhotosToCatalog.cpp:415 reissue_repaint_collections(), scheduling reissue on all collections

Looks like only one image was being processed and that it processed successfully.  Did you do another operation shortly thereafter (still in the minute of 9:37)?

-Kirk

[guang]

hi Kirk
The hang happens within a couple of seconds of when I try to add or remove the images.  As far as I know, I dont do any other operation during this time.  And the adding or removing that causes the hang is ultimately successful -- the pics and the metadata seem to end up where I want them.   It's just that I frequently have to restart the app and reopen the catalog/collection to continue my work.

Im turning off all my system extensions to see if that has any beneficial effect.

-mark

[Kirk Baker]

Mark,

The hang happens within a couple of seconds of when I try to add or remove the images.  As far as I know, I dont do any other operation during this time.  And the adding or removing that causes the hang is ultimately successful -- the pics and the metadata seem to end up where I want them.   It's just that I frequently have to restart the app and reopen the catalog/collection to continue my work.

OK.  I see that I wasn't clear in my question.  In the minute of 9:37, did you process (add) one image only or did you add the one image and then select some more images and try to add them after you added the one image?  I'm trying to find out if there was a possible second set of image(s) that were added and there was no output at all in the log for adding them.

-Kirk

[guang]

Kirk,
I see.  No, it was just one image.

Mark

[Kirk Baker]

Mark,

I see.  No, it was just one image.

I'm thinking that it would be worthwhile to do a screen share session and you can demonstrate the issue to me.  Do you have a fairly fast internet connection?

Thanks,

-Kirk

[guang]

Kirk
That should be no problem; I do have a pretty fast fiber connection.   Since restarting after turning off the system extensions, however, I havent been able to make it reoccur yet, although I have not been using it heavily as Im working on something else in a different app right now.  If and when it starts happening again regularly, can we arrange a time to share the screen?

thanks
Mark

[Kirk Baker]

Mark,

That should be no problem; I do have a pretty fast fiber connection.   Since restarting after turning off the system extensions, however, I havent been able to make it reoccur yet, although I have not been using it heavily as Im working on something else in a different app right now.  If and when it starts happening again regularly, can we arrange a time to share the screen?

Yes, absolutely.  Click on my name to the left of this message and send me a personal message and we'll arrange the details privately.

-Kirk

[guang]

ok sounds good

[guang]

hi Kirk
Had a different instance just now.  I tried to option click to select all my 5 star shots in a collection and it froze. The selected images just showed up as empty frames.  All my system extensions are off.   I have to head out now but I will try to recreate tomorrow and will PM you so I can show you via screen share.

best
Mark

[guang]

Kirk

See attached .mov.    I got it to hang the more common way, when removing a pic from a collection.   I didnt click the Abort button when recording the video, but when clicked it just blinked and did nothing, as usual, so I restarted the app and retrieved the log.

-mark

[Kirk Baker]

Mike,

That's very strange.  While I wish I could see the entire progress dialog in your video, I can see that it says "...35 selected items..." when you actually have no items selected at all (at least that's what the status bar says at the bottom of the Contact Sheet window.)  I'll assume that it really says "Getting metadata for 0 of 35 selected items...".  If there are no items selected then what is wanting the metadata to be loaded?

I'm confused as to what would be the cause, but I'm still thinking that a screen share session will help me understand more and is worthwhile.

-Kirk

[guang]

Yes, sorry it did say “Getting metadata for 0 of 35 selected items.”.  I had copied that but forgot to paste it into my msg.  Once the problem starts again today i’ll let you know.

-mark

[Ethan Welty]

I am experiencing the same or similar problem.

Photo Mechanic Plus Version 6.0, build 6097 (85d1687)
Mac OS X 11.4

Steps to reproduce:

Collection has 27 images.
Open the collection, sort by arrangement, and change the order. Leave the collection open as a contact sheet. These conditions seem necessary for the bug to occur.
Then Search > [search for images] > [right click on an image] > Add to collection
Getting Metadata for 0 of 28 images dialogue appears (bottom bar says "Selected 1 of 28"). Hangs forever.
Force quite Photo Mechanic.
Upon restart, the new image is in the collection.

The only database logs fired when this happens look like this:
[Wed Nov-24-2021 10:26:28.336][1131bae00][10058888] AddPhotosToCatalog.cpp:415 reissue_repaint_collections(), scheduling reissue on all collections

With CATALOG_DEBUG_LOADING.
Adding METADATA_PRELOAD_LOGGING does not add more lines to the log for the moment between clicking "Add to collection" and the application freezes.