Can't Get Updated Metadata to Save

[HokiePerogi]

I'm trying to update the metadata for one of my DVD's, Iron Man 2. In BMT the metadata is completely blank. The only thing showing is the title which I believe is being derived from the folder structure.

When I go into the title and follow the "Find Meta Data" flow, the fields get populated beautifully in BMT.....until I hit "Save". As soon as I hit "Save" all of the fields are blanked out again.

Can someone direct me on how to debug the issue?


Thanks!

[stuckless]

Originally Posted by HokiePerogi

I'm trying to update the metadata for one of my DVD's, Iron Man 2. In BMT the metadata is completely blank. The only thing showing is the title which I believe is being derived from the folder structure.

When I go into the title and follow the "Find Meta Data" flow, the fields get populated beautifully in BMT.....until I hit "Save". As soon as I hit "Save" all of the fields are blanked out again.

Can someone direct me on how to debug the issue?


Thanks!

Does it happen for all videos, or just this one? I have seen cases where SageTV will not update the metadata on one item (for whatever reason). My solution, if it's just one file, is to remove the dvd, then tell sagetv to refresh (so that it knows it is gone) and then add it back in again, and tell sagetv to refresh (so that it picks it up) and then see if you can edit/update the metadata. Again, this is not really a bmt thing, since when this happens to me, it's only for a single item.

[HokiePerogi]

Originally Posted by stuckless

Does it happen for all videos, or just this one? I have seen cases where SageTV will not update the metadata on one item (for whatever reason). My solution, if it's just one file, is to remove the dvd, then tell sagetv to refresh (so that it knows it is gone) and then add it back in again, and tell sagetv to refresh (so that it picks it up) and then see if you can edit/update the metadata.

It is only happening for this one particular file. I tried your approach of removing the BD folder structure, refreshing sagetv imports, adding the BD folder structure back and refreshing one more time.

I then tried to update the metadata again, but no luck.

Is there some logging I can switch to debug and look at?

[stuckless]

Originally Posted by HokiePerogi

It is only happening for this one particular file. I tried your approach of removing the BD folder structure, refreshing sagetv imports, adding the BD folder structure back and refreshing one more time.

I then tried to update the metadata again, but no luck.

Is there some logging I can switch to debug and look at?

Unfortunately, there isn't anything that BMT will log for that, since no errors would have been generated. BMT simply calls the SageTV api for saving metadata and it never fails with an error.

You can try looking in the logs/phoenix.log to see if there are any other errors listed there. Maybe there is something else going on... weird video path, title, etc.

[HokiePerogi]

Originally Posted by stuckless

You can try looking in the logs/phoenix.log to see if there are any other errors listed there. Maybe there is something else going on... weird video path, title, etc.

Here's what I'm seeing:

2011-06-23 14:08:27,537 [16299147@qtp-17371297-5] INFO sagex.phoenix.metadata.MetadataManager - Saving Metadata for SageMediaFile [sageId=2458746, sageObject=MediaFile[id=2458746 A[2458784,2458747,"Iron Man 2",0@0623.14:04,0] mask=B host=SagePC encodedBy= format=null P:\Videos\Movies\BluRay Movies\Iron Man 2\BDMV, Seg0[Thu 6/23 14:04:06.237-Thu 6/23 14:04:06.238]]]; Hints: Hints [hints={update_metadata: true,update_fanart: true,preserve_original: false,scan_missing_metadata: false,scan_subfolders: false,import_tv_as_recording: false,}]
2011-06-23 14:08:27,537 [16299147@qtp-17371297-5] INFO sagex.phoenix.metadata.persistence.Sage7Persistence - Storing updated metadata for item SageMediaFile [sageId=2458746, sageObject=MediaFile[id=2458746 A[2458784,2458747,"Iron Man 2",0@0623.14:04,0] mask=B host=SagePC encodedBy= format=null P:\Videos\Movies\BluRay Movies\Iron Man 2\BDMV, Seg0[Thu 6/23 14:04:06.237-Thu 6/23 14:04:06.238]]]
2011-06-23 14:08:27,547 [16299147@qtp-17371297-5] INFO sagex.phoenix.metadata.MetadataManager - Saving Phoenix Fanart for SageMediaFile [sageId=2458746, sageObject=MediaFile[id=2458746 A[2458784,2458747,"Iron Man 2",0@0623.14:04,0] mask=B host=SagePC encodedBy= format=null P:\Videos\Movies\BluRay Movies\Iron Man 2\BDMV, Seg0[Thu 6/23 14:04:06.237-Thu 6/23 14:04:06.238]]]; Hints: Hints [hints={update_metadata: true,update_fanart: true,preserve_original: false,scan_missing_metadata: false,scan_subfolders: false,import_tv_as_recording: false,}]
...
2011-06-23 14:08:27,553 [16299147@qtp-17371297-5] WARN sagex.phoenix.fanart.FanartStorage - No BANNER for C:\fanart\Movies\Iron Man 2\Banners in the metadata.
2011-06-23 14:08:27,553 [16299147@qtp-17371297-5] INFO sagex.phoenix.fanart.FanartStorage - Skipping Image file: http://cf1.imgobject.com/posters/cf4...2-original.jpg because it's in the image skip file.
...
2011-06-23 14:08:27,558 [16299147@qtp-17371297-5] WARN sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\fanart\Movies\Iron Man 2\Actors in the metadata.
2011-06-23 14:08:27,558 [16299147@qtp-17371297-5] WARN sagex.phoenix.fanart.FanartStorage - No EPISODE for C:\fanart\Movies\Iron Man 2\Episodes in the metadata.
2011-06-23 14:08:27,558 [16299147@qtp-17371297-5] WARN phoenix.impl.MediaAPI - Invalid year for Movie, so ignoring Title Mask for SageMediaFile [sageId=2458746, sageObject=MediaFile[id=2458746 A[2458784,2458747,"Iron Man 2",0@0623.14:04,0] mask=B host=SagePC encodedBy= format=null P:\Videos\Movies\BluRay Movies\Iron Man 2\BDMV, Seg0[Thu 6/23 14:04:06.237-Thu 6/23 14:04:06.238]]]

I'm trying to track down my SageTV log files now to see if there is an error showing up there.

[Spectrum]

Originally Posted by stuckless

Does it happen for all videos, or just this one? I have seen cases where SageTV will not update the metadata on one item (for whatever reason). My solution, if it's just one file, is to remove the dvd, then tell sagetv to refresh (so that it knows it is gone) and then add it back in again, and tell sagetv to refresh (so that it picks it up) and then see if you can edit/update the metadata. Again, this is not really a bmt thing, since when this happens to me, it's only for a single item.

I've noticed this happening on and off for some time. Sometimes it is any changes to the offending file and sometimes it is only certain things that can't be changed. I've noticed now that there is the option to edit the "Raw Metadata" sometimes going that route will make the settings stick; sometimes it won't.

[stuckless]

Originally Posted by Spectrum

I've noticed this happening on and off for some time. Sometimes it is any changes to the offending file and sometimes it is only certain things that can't be changed. I've noticed now that there is the option to edit the "Raw Metadata" sometimes going that route will make the settings stick; sometimes it won't.

I'm not sure there is much the debugging log would show me. If this is a case where it happens sometimes on some files, I'm not sure I can resolve it... or even if the issue is in BMT or not.

[Spectrum]

Hmm the only thing in the log out of the ordinary for that file is (apparently too long to post in code tags) in the attached log snippit. Not sure if that helps, but that is the one that I couldn't change from an import to a recording.

As far as debugging, without looking at return values from the db commit using the api I don't know what else could be done; I'm just throwing things out and hoping something sticks. This is not a huge issue, but it it is one that I have encountered numerous times and it boggles my mind why it's something that you can't reproduce

[stuckless]

Is CSI Miami one of the shows that you are having issues with? What's interesting here, is that for Airings (ie, non media files), Phoenix creates an Immutable Metadata object so that any writes are ignored, since you can write data to an airing.

If this is a MediaFile, then it really is odd that it's getting assigned an Immutable metadata object.

[Spectrum]

Originally Posted by stuckless

Is CSI Miami one of the shows that you are having issues with? What's interesting here, is that for Airings (ie, non media files), Phoenix creates an Immutable Metadata object so that any writes are ignored, since you can write data to an airing.

If this is a MediaFile, then it really is odd that it's getting assigned an Immutable metadata object.

I don't usually tinker with CSI Miami; that episode just happened to be one I had a problem with recently and thought I'd add to the post because I still have the file and can slap it around for troubleshooting.

I was attempting to change it from a media file to an airing and it wouldn't let me. Is there any way I can dump the db entry for that file so you can see everything that is set for it and would that even help?

[Spectrum]

More info:
I ran into another one today

The last line of the log snippit below makes it appear that BMT is attempting to import it as a recording. I'm guessing that sage is refusing the db update? Is there any way to check a return value from the call to the sage api to diagnose what is going on?

2011-06-28 13:04:32,743 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.MetadataManager - Saving Metadata for SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195332,10195331,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280289556, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]; Hints: Hints [hints={update_metadata: true,update_fanart: true,preserve_original: false,scan_missing_metadata: false,scan_subfolders: false,import_tv_as_recording: false,}]
2011-06-28 13:04:32,743 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.persistence.Sage7Persistence - Storing updated metadata for item SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195332,10195331,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280289556, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]
2011-06-28 13:04:32,781 [19094380@qtp-12210700-8] WARN  sagex.phoenix.metadata.persistence.Sage7Persistence - Failed to update tv series info for: MythBusters
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.MetadataManager - Saving Phoenix Fanart for SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195332,10195331,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280672782, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]; Hints: Hints [hints={update_metadata: true,update_fanart: true,preserve_original: false,scan_missing_metadata: false,scan_subfolders: false,import_tv_as_recording: false,}]
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BACKGROUND for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Backgrounds in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BACKGROUND for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Backgrounds in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Banners in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Banners in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No POSTER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Posters in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No POSTER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Posters in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Actors in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Actors in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No EPISODE for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Episodes in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No EPISODE for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Episodes in the metadata.
2011-06-28 13:04:32,795 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.MetadataManager - Imported MediaFile as Recording: SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195335,10195334,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280672782, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]

[stuckless]

Originally Posted by Spectrum

More info:
I ran into another one today

The last line of the log snippit below makes it appear that BMT is attempting to import it as a recording. I'm guessing that sage is refusing the db update? Is there any way to check a return value from the call to the sage api to diagnose what is going on?

2011-06-28 13:04:32,743 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.MetadataManager - Saving Metadata for SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195332,10195331,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280289556, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]; Hints: Hints [hints={update_metadata: true,update_fanart: true,preserve_original: false,scan_missing_metadata: false,scan_subfolders: false,import_tv_as_recording: false,}]
2011-06-28 13:04:32,743 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.persistence.Sage7Persistence - Storing updated metadata for item SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195332,10195331,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280289556, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]
2011-06-28 13:04:32,781 [19094380@qtp-12210700-8] WARN  sagex.phoenix.metadata.persistence.Sage7Persistence - Failed to update tv series info for: MythBusters
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.MetadataManager - Saving Phoenix Fanart for SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195332,10195331,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280672782, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]; Hints: Hints [hints={update_metadata: true,update_fanart: true,preserve_original: false,scan_missing_metadata: false,scan_subfolders: false,import_tv_as_recording: false,}]
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BACKGROUND for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Backgrounds in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BACKGROUND for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Backgrounds in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Banners in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Banners in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No POSTER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Posters in the metadata.
2011-06-28 13:04:32,783 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No POSTER for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Posters in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Actors in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Actors in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No EPISODE for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Episodes in the metadata.
2011-06-28 13:04:32,784 [19094380@qtp-12210700-8] WARN  sagex.phoenix.fanart.FanartStorage - No EPISODE for C:\SageTV\SageTV\userdata\Phoenix\Fanart\TV\MythBusters\Season 8\Episodes in the metadata.
2011-06-28 13:04:32,795 [19094380@qtp-12210700-8] INFO  sagex.phoenix.metadata.MetadataManager - Imported MediaFile as Recording: SageMediaFile [sageId=10195315, sageObject=MediaFile[id=10195315 A[10195335,10195334,"MythBusters",0@0628.12:05,43] mask=V host=HTPC encodedBy= format=AVI 0:43:19 1129 kbps [#0 Video[MPEG4-Video 29.97 fps 624x352 39:22 progressive]#1 Audio[MP3 48000 Hz 2 channels 128 kbps idx=1]{SeriesInfoID=557678, ScrapedBy=Phoenix, MediaType=TV, ScrapedDate=1309280672782, UserRating=76, MediaProviderDataID=73388, MediaTitle=MythBusters, MediaProviderID=tvdb}] D:\Recordings1\MythBusters S08E08.avi, Seg0[Tue 6/28 12:05:00.076-Tue 6/28 12:48:19.866]]]

That is interesting, since that line is "Imported", and is written after the item has been imported as a recording. Again, I'm not sure why it would revert later