2010-07-20 12:29:09,109 [SageTV] INFO  sagex.phoenix.Phoenix - Initializing Phoenix
2010-07-20 12:29:09,109 [SageTV] INFO  sagex.phoenix.event.HandlerManager - Registering Event Handler: sagex.phoenix.event.message.SageSystemMessageHandler for Event Type: sagex.phoenix.event.message.SystemMessageEvent
2010-07-20 12:29:09,125 [SageTV] INFO  sagex.phoenix.factory.FactoryRegistry - Cleaning Factory: sagex.phoenix.factory.FactoryRegistry@3e59ca
2010-07-20 12:29:09,125 [SageTV] INFO  sagex.phoenix.factory.FactoryRegistry - Cleaning Factory: sagex.phoenix.factory.FactoryRegistry@17906f4
2010-07-20 12:29:09,125 [SageTV] INFO  sagex.phoenix.factory.FactoryRegistry - Cleaning Factory: sagex.phoenix.factory.FactoryRegistry@b7bc80
2010-07-20 12:29:09,125 [SageTV] INFO  sagex.phoenix.factory.FactoryRegistry - Cleaning Factory: sagex.phoenix.factory.FactoryRegistry@b89bc5
2010-07-20 12:29:09,125 [SageTV] INFO  sagex.phoenix.factory.FactoryRegistry - Cleaning Factory: sagex.phoenix.factory.FactoryRegistry@1fac7cf
2010-07-20 12:29:09,125 [SageTV] INFO  sagex.phoenix.vfs.VFSManager - Processing VFS File: .\STVs\Phoenix\vfs\vfs.xml
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: genre; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: genre; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: genre; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: genre; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: rating; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: rating; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:09,328 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sageimports
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagevideoimports
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagevideoimportsv7
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagedvd
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagebluray
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagedvideos
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagerecordings
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,171 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: sagerecordingsarchived
2010-07-20 12:29:11,187 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:11,187 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: mediatype; doesn't have a folder.
2010-07-20 12:29:11,187 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: tvseason
2010-07-20 12:29:11,187 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: onlinevideos
2010-07-20 12:29:11,187 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,234 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,234 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,234 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: filtertest
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: missingmetadata; doesn't have a folder.
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: missingmetadataview
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: year; doesn't have a folder.
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: videobyyear
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.vfs.views.FolderOperation - FolderOperation: title; doesn't have a folder.
2010-07-20 12:29:11,265 [SageTV] WARN  sagex.phoenix.factory.FactoryRegistry - Missing registered factory for id: moviegenres
2010-07-20 12:29:11,265 [SageTV] INFO  sagex.phoenix.event.HandlerManager - Registering Event Handler: sagex.phoenix.vfs.VFSManager for Event Type: sagex.phoenix.vfs.VFSManager
2010-07-20 12:29:11,265 [SageTV] INFO  sagex.phoenix.configuration.DirectoryMetadataLoader - Loading Configurations from directory: C:\Program Files\SageTV\SageTV\.\STVs\Phoenix\Configuration
2010-07-20 12:29:11,265 [SageTV] INFO  sagex.phoenix.configuration.DirectoryMetadataLoader - Loading Xml Metadata: C:\Program Files\SageTV\SageTV\.\STVs\Phoenix\Configuration\log4j.xml
2010-07-20 12:29:11,281 [SageTV] INFO  sagex.phoenix.configuration.DirectoryMetadataLoader - Loading Xml Metadata: C:\Program Files\SageTV\SageTV\.\STVs\Phoenix\Configuration\Phoenix.xml
2010-07-20 12:29:11,421 [SageTV] INFO  sagex.phoenix.configuration.DirectoryMetadataLoader - Loading Xml Metadata: C:\Program Files\SageTV\SageTV\.\STVs\Phoenix\Configuration\Sage.xml
2010-07-20 12:29:11,453 [SageTV] INFO  sagex.phoenix.configuration.DirectoryMetadataLoader - Loading Configurations from directory: C:\Program Files\SageTV\SageTV\.\STVs\Phoenix\Configuration\ext
2010-07-20 12:29:11,453 [SageTV] INFO  sagex.phoenix.configuration.DirectoryMetadataLoader - Loading Xml Metadata: C:\Program Files\SageTV\SageTV\.\STVs\Phoenix\Configuration\ext\log4j.xml
2010-07-20 12:29:11,453 [SageTV] INFO  sagex.phoenix.configuration.impl.SageConfigurationProvider - SageConfigurationProvider does not use load()
2010-07-20 12:29:11,578 [SageTV] INFO  sagex.phoenix.metadata.MetadataManager - Loading XBMC Metadata Scraper: .\STVs\Phoenix\scrapers\xbmc\video\imdb.xml
2010-07-20 12:29:12,359 [SageTV] INFO  sagex.phoenix.Phoenix - Phoenix Initialized
2010-07-20 12:29:12,359 [SageTV] INFO  sagex.phoenix.util.url.CachedUrlCleanupTask - Url Cleanup Task Created
2010-07-20 12:29:12,359 [SageTV] INFO  sagex.phoenix.util.TaskManager - Adding Scheduled Task: urlcachecleaner; Date: Tue Jul 20 12:29:12 EDT 2010; Repeat: 86400000
2010-07-20 12:29:12,359 [Timer-0] INFO  sagex.phoenix.util.url.CachedUrlCleanupTask - Begin URL Cache Cleanup
2010-07-20 12:29:17,328 [Timer-0] INFO  sagex.phoenix.util.url.CachedUrlCleanupTask - Finished URL Cache Cleanup; Cleaned 0 items.
2010-07-20 12:29:20,703 [SageTV] INFO  sagex.phoenix.plugin.PhoenixPlugin - Setting New Custom Metadata Fields: EpisodeTitle;DiscNumber;EpisodeNumber;Fanart;IMDBID;MediaProviderDataID;MediaProviderID;MediaTitle;MediaType;SeasonNumber;UserRating
2010-07-20 12:29:20,703 [Timer-6] INFO  sagex.phoenix.plugin.PhoenixPlugin - Begin: Phoenix looking for plugins that contribute to the Phoenix Core...
2010-07-20 12:29:20,703 [Timer-6] INFO  sagex.phoenix.plugin.PhoenixPlugin - End: Phoenix looking for plugins that contribute to the Phoenix Core
2010-07-20 12:30:08,234 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Sage Imports (Combined) V6; id: sagevideoimports
2010-07-20 12:30:08,328 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Sage Import Folders; id: sageimports
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Sage Import Folders in 31ms
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=3 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture Composite format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=4 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture S-Video format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=5 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture Digital TV Tuner format=MPEG2-PS 0:00:00 0 kbps []]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=6 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 Composite_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=7 FA[A[7,0,"mtvU Video Hour",0@0720.12:29,5256000]] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture TV Tuner format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=8 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 TV Tuner format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=9 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 S-Video_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=10 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture Composite_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=11 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 Composite format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=13 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 Digital TV Tuner format=MPEG2-PS 0:00:00 0 kbps []]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=14 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 S-Video format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=15 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture S-Video_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=17 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture S-Video format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=18 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture Digital TV Tuner format=MPEG2-PS 0:00:00 0 kbps []]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=19 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 Composite_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=21 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 TV Tuner format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=22 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 S-Video_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=23 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture Composite_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=24 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 Composite format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=26 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 Digital TV Tuner format=MPEG2-PS 0:00:00 0 kbps []]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=27 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture #2 S-Video format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=28 FA[BAD AIRING] mask=V host=mediacenter encodedBy=Hauppauge WinTV-7164 Analog Capture S-Video_2 format=MPEG2-PS 0:00:00 0 kbps [#0 Video[MPEG2-Video 29.97 fps 720x480 4:3 3800 kbps interlaced]#1 Audio[MP2 48000 Hz 2 channels 384 kbps]]]
2010-07-20 12:30:08,359 [32716219@qtp-17346346-7] WARN  sagex.phoenix.vfs.sage.SageVirtualFilesystemMediaFolder - No File Segment for Sage File: MediaFile[id=29 FA[BAD AIRING] mask=D host=mediacenter encodedBy= format=DVD 0:00:00 0 kbps []]
2010-07-20 12:30:08,421 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Sage Import Folders in 93ms
2010-07-20 12:30:08,453 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Sage Imports (Combined) V6 in 219ms
2010-07-20 12:30:11,984 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Sage Imports (Combined) V7; id: sagevideoimportsv7
2010-07-20 12:30:11,984 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Sage File System; id: sagefilesystem
2010-07-20 12:30:12,156 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Sage File System in 172ms
2010-07-20 12:30:12,171 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Sage File System in 187ms
2010-07-20 12:30:12,171 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Sage Imports (Combined) V7 in 187ms
2010-07-20 12:30:17,156 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Videos; id: sagedvideos
2010-07-20 12:30:17,156 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Vidoes; id: video
2010-07-20 12:30:17,187 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Vidoes in 31ms
2010-07-20 12:30:17,187 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Vidoes in 31ms
2010-07-20 12:30:17,187 [32716219@qtp-17346346-7] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Videos in 31ms
2010-07-20 12:32:41,375 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Videos; id: sagedvideos
2010-07-20 12:32:41,375 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Vidoes; id: video
2010-07-20 12:32:41,390 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Vidoes in 15ms
2010-07-20 12:32:41,390 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Vidoes in 15ms
2010-07-20 12:32:41,390 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Videos in 15ms
2010-07-20 12:33:07,734 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - search(): imdb,tmdb; SearchQuery; Type: MOVIE; QUERY:Rambo;YEAR:1988;
2010-07-20 12:33:07,734 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Searching: Rambo using IMDBMetadataProvider[MetadataProviderInfo [id=imdb, fanartId=tmdb, mediaTypes=[MOVIE], name=IMDb]]
2010-07-20 12:33:07,796 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.URLSaxParser - Parsing Url: http://www.imdb.com/find?s=tt&q=Rambo&x=0&y=0
2010-07-20 12:33:07,812 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.CachedUrlFactory - Caching URL Factory in use.
2010-07-20 12:33:11,843 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Fetching Metadata for MediaSearchResult [extraArgs=empty, id=tt0095956, imdbId=null, metadata=null, providerId=imdb, score=0.8, title=Rambo III, type=MOVIE, url=http://www.imdb.com/title/tt0095956/, year=1988]
2010-07-20 12:33:11,859 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.URLSaxParser - Parsing Url: http://www.imdb.com/title/tt0095956/
2010-07-20 12:33:12,171 [23392283@qtp-17346346-4] WARN  phoenix.log - Failed to parse date string: 25 May 1988 (USA); Attempting again using: 25 May 1988
2010-07-20 12:33:12,187 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Fetching Fanart from alternate source: tmdb for result: MediaSearchResult [extraArgs=empty, id=tt0095956, imdbId=null, metadata=null, providerId=imdb, score=0.8, title=Rambo III, type=MOVIE, url=http://www.imdb.com/title/tt0095956/, year=1988]
2010-07-20 12:33:12,218 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.provider.tmdb.TheMovieDBItemParser - Fetching TMDB Metadata: http://api.themoviedb.org/2.1/Movie.imdbLookup/en/xml/d4ad46ee51d364386b6cf3b580fb5d8c/tt0095956
2010-07-20 12:33:14,906 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Saving Metadata for Resource[Id: TMP19355029, Title: Rambo]
2010-07-20 12:33:15,515 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Saving Phoenix Fanart for Resource[Id: TMP19355029, Title: Rambo]
2010-07-20 12:33:15,562 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//backdrops/d05/4bc91009017a3c57fe005d05/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Backgrounds\rambo-iii-original.jpg; WithScale: 1024
2010-07-20 12:33:15,656 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//backdrops/d05/4bc91009017a3c57fe005d05/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Backgrounds\rambo-iii-original.jpg; with scale: 1024
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//backdrops/d05/4bc91009017a3c57fe005d05/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:15,671 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//backdrops/d09/4bc91009017a3c57fe005d09/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Backgrounds\rambo-iii-original.jpg; WithScale: 1024
2010-07-20 12:33:15,703 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//backdrops/d09/4bc91009017a3c57fe005d09/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Backgrounds\rambo-iii-original.jpg; with scale: 1024
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//backdrops/d09/4bc91009017a3c57fe005d09/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:15,718 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//backdrops/224/4c2ce2717b9aa15e9a000224/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Backgrounds\rambo-iii-original.jpg; WithScale: 1024
2010-07-20 12:33:15,765 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//backdrops/224/4c2ce2717b9aa15e9a000224/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Backgrounds\rambo-iii-original.jpg; with scale: 1024
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//backdrops/224/4c2ce2717b9aa15e9a000224/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:15,765 [23392283@qtp-17346346-4] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Banners in the metadata.
2010-07-20 12:33:15,765 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://ia.media-imdb.com/images/M/MV5BMTM2ODg0OTQzNF5BMl5BanBnXkFtZTcwMDk2MDcyMQ@@._V1._SX512_SY512_.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\MV5BMTM2ODg0OTQzNF5BMl5BanBnXkFtZTcwMDk2MDcyMQ@@._V1._SX512_SY512_.jpg; WithScale: 200
2010-07-20 12:33:16,109 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 360x500 to 200x277
2010-07-20 12:33:16,390 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//posters/d1c/4bc9100d017a3c57fe005d1c/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; WithScale: 200
2010-07-20 12:33:16,421 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//posters/d1c/4bc9100d017a3c57fe005d1c/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; with scale: 200
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//posters/d1c/4bc9100d017a3c57fe005d1c/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:16,437 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//posters/d17/4bc9100d017a3c57fe005d17/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; WithScale: 200
2010-07-20 12:33:16,500 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//posters/d17/4bc9100d017a3c57fe005d17/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; with scale: 200
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//posters/d17/4bc9100d017a3c57fe005d17/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:16,500 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//posters/d12/4bc9100a017a3c57fe005d12/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; WithScale: 200
2010-07-20 12:33:16,546 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//posters/d12/4bc9100a017a3c57fe005d12/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; with scale: 200
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//posters/d12/4bc9100a017a3c57fe005d12/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:16,546 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//posters/d0d/4bc91009017a3c57fe005d0d/rambo-iii-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; WithScale: 200
2010-07-20 12:33:16,593 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//posters/d0d/4bc91009017a3c57fe005d0d/rambo-iii-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Posters\rambo-iii-original.jpg; with scale: 200
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//posters/d0d/4bc91009017a3c57fe005d0d/rambo-iii-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:33:16,593 [23392283@qtp-17346346-4] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo III\Actors in the metadata.
2010-07-20 12:33:22,656 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Videos; id: sagedvideos
2010-07-20 12:33:22,656 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Vidoes; id: video
2010-07-20 12:33:22,656 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Vidoes in 0ms
2010-07-20 12:33:22,656 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Vidoes in 0ms
2010-07-20 12:33:22,656 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Videos in 0ms
2010-07-20 12:33:41,421 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - search(): imdb,tmdb; SearchQuery; Type: MOVIE; QUERY:Rambo;YEAR:2008;
2010-07-20 12:33:41,421 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Searching: Rambo using IMDBMetadataProvider[MetadataProviderInfo [id=imdb, fanartId=tmdb, mediaTypes=[MOVIE], name=IMDb]]
2010-07-20 12:33:41,421 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.URLSaxParser - Parsing Url: http://www.imdb.com/find?s=tt&q=Rambo&x=0&y=0
2010-07-20 12:33:42,984 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Fetching Metadata for MediaSearchResult [extraArgs=empty, id=tt0462499, imdbId=null, metadata=null, providerId=imdb, score=1.0, title=Rambo, type=MOVIE, url=http://www.imdb.com/title/tt0462499/, year=2008]
2010-07-20 12:33:42,984 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.URLSaxParser - Parsing Url: http://www.imdb.com/title/tt0462499/
2010-07-20 12:33:43,312 [23392283@qtp-17346346-4] WARN  phoenix.log - Failed to parse date string: 25 January 2008 (USA); Attempting again using: 25 January 2008
2010-07-20 12:33:43,312 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Fetching Fanart from alternate source: tmdb for result: MediaSearchResult [extraArgs=empty, id=tt0462499, imdbId=null, metadata=null, providerId=imdb, score=1.0, title=Rambo, type=MOVIE, url=http://www.imdb.com/title/tt0462499/, year=2008]
2010-07-20 12:33:43,343 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.provider.tmdb.TheMovieDBItemParser - Fetching TMDB Metadata: http://api.themoviedb.org/2.1/Movie.imdbLookup/en/xml/d4ad46ee51d364386b6cf3b580fb5d8c/tt0462499
2010-07-20 12:33:45,562 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Saving Metadata for Resource[Id: TMP23314523, Title: Rambo]
2010-07-20 12:33:46,000 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Saving Phoenix Fanart for Resource[Id: TMP23314523, Title: Rambo]
2010-07-20 12:33:46,015 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/backdrops/747/4bc91f89017a3c57fe00c747/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Backgrounds\rambo-original.jpg; WithScale: 1024
2010-07-20 12:33:46,640 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1920x1080 to 1024x576
2010-07-20 12:33:47,500 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/backdrops/75b/4bc91f8b017a3c57fe00c75b/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Backgrounds\Fanart-767382848025439180.jpg; WithScale: 1024
2010-07-20 12:33:48,156 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1920x1080 to 1024x576
2010-07-20 12:33:48,937 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/backdrops/76b/4bc91f90017a3c57fe00c76b/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Backgrounds\Fanart-4786869662600860751.jpg; WithScale: 1024
2010-07-20 12:33:49,531 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1920x1080 to 1024x576
2010-07-20 12:33:50,312 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/backdrops/767/4bc91f8d017a3c57fe00c767/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Backgrounds\Fanart-8757831675066139136.jpg; WithScale: 1024
2010-07-20 12:33:51,500 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1920x1080 to 1024x576
2010-07-20 12:33:52,296 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/backdrops/763/4bc91f8c017a3c57fe00c763/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Backgrounds\Fanart-7745287274493215027.jpg; WithScale: 1024
2010-07-20 12:33:53,125 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1920x1080 to 1024x576
2010-07-20 12:33:53,906 [23392283@qtp-17346346-4] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Banners in the metadata.
2010-07-20 12:33:53,906 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://ia.media-imdb.com/images/M/MV5BMTI5Mjg1MzM4NF5BMl5BanBnXkFtZTcwNTAyNzUzMw@@._V1._SX512_SY512_.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Posters\Fanart-167788750920697909.jpg; WithScale: 200
2010-07-20 12:33:53,984 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 345x512 to 200x296
2010-07-20 12:33:54,062 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/posters/786/4bc91f92017a3c57fe00c786/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Posters\rambo-original.jpg; WithScale: 200
2010-07-20 12:33:54,593 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1013x1500 to 200x296
2010-07-20 12:33:54,984 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/posters/795/4bc91f96017a3c57fe00c795/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Posters\Fanart-7454144483932096199.jpg; WithScale: 200
2010-07-20 12:33:55,437 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1000x1444 to 200x288
2010-07-20 12:33:55,781 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/posters/7a4/4bc91f97017a3c57fe00c7a4/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Posters\Fanart-1081974953038946677.jpg; WithScale: 200
2010-07-20 12:33:56,421 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1000x1500 to 200x300
2010-07-20 12:33:56,765 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org/posters/79f/4bc91f96017a3c57fe00c79f/rambo-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Posters\Fanart-7299385865507755118.jpg; WithScale: 200
2010-07-20 12:33:57,203 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 1000x1500 to 200x300
2010-07-20 12:33:57,546 [23392283@qtp-17346346-4] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo\Actors in the metadata.
2010-07-20 12:33:59,203 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Videos; id: sagedvideos
2010-07-20 12:33:59,203 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Vidoes; id: video
2010-07-20 12:33:59,203 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Vidoes in 0ms
2010-07-20 12:33:59,218 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Vidoes in 15ms
2010-07-20 12:33:59,218 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Videos in 15ms
2010-07-20 12:34:10,640 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - search(): imdb,tmdb; SearchQuery; Type: MOVIE; QUERY:Rambo: First Blood;YEAR:1982;
2010-07-20 12:34:10,640 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Searching: Rambo: First Blood using IMDBMetadataProvider[MetadataProviderInfo [id=imdb, fanartId=tmdb, mediaTypes=[MOVIE], name=IMDb]]
2010-07-20 12:34:10,640 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.URLSaxParser - Parsing Url: http://www.imdb.com/find?s=tt&q=Rambo%3A+First+Blood&x=0&y=0
2010-07-20 12:34:11,500 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Searching: Rambo: First Blood using TheMovieDBMetadataProvider[MetadataProviderInfo [id=tmdb, fanartId=tmdb, mediaTypes=[MOVIE], name=themoviedb.org]]
2010-07-20 12:34:11,515 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.provider.tmdb.TheMovieDBMetadataProvider - Fetching tmdb url: CachedUrl: http://api.themoviedb.org/2.1/Movie.search/en/xml/d4ad46ee51d364386b6cf3b580fb5d8c/Rambo%253A%2BFirst%2BBlood; UrlId: f3e79e45d520bc645e3c01a1a7ac52da
2010-07-20 12:34:11,593 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.provider.tmdb.TheMovieDBMetadataProvider - TMDB Search for SearchQuery; Type: MOVIE; QUERY:Rambo: First Blood;YEAR:1982; returned no results.
2010-07-20 12:34:17,703 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Fetching Metadata for MediaSearchResult [extraArgs=empty, id=tt0083944, imdbId=null, metadata=null, providerId=imdb, score=0.7619048, title=First Blood, type=MOVIE, url=http://www.imdb.com/title/tt0083944/, year=1982]
2010-07-20 12:34:17,703 [23392283@qtp-17346346-4] INFO  sagex.phoenix.util.url.URLSaxParser - Parsing Url: http://www.imdb.com/title/tt0083944/
2010-07-20 12:34:18,203 [23392283@qtp-17346346-4] WARN  phoenix.log - Failed to parse date string: 22 October 1982 (USA); Attempting again using: 22 October 1982
2010-07-20 12:34:18,203 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Fetching Fanart from alternate source: tmdb for result: MediaSearchResult [extraArgs=empty, id=tt0083944, imdbId=null, metadata=null, providerId=imdb, score=0.7619048, title=First Blood, type=MOVIE, url=http://www.imdb.com/title/tt0083944/, year=1982]
2010-07-20 12:34:18,218 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.provider.tmdb.TheMovieDBItemParser - Fetching TMDB Metadata: http://api.themoviedb.org/2.1/Movie.imdbLookup/en/xml/d4ad46ee51d364386b6cf3b580fb5d8c/tt0083944
2010-07-20 12:34:28,687 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Saving Metadata for Resource[Id: TMP32100485, Title: Rambo: First Blood]
2010-07-20 12:34:29,031 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.MetadataManager - Saving Phoenix Fanart for Resource[Id: TMP32100485, Title: Rambo: First Blood]
2010-07-20 12:34:29,031 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//backdrops/ce1/4bc91004017a3c57fe005ce1/first-blood-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Backgrounds\first-blood-original.jpg; WithScale: 1024
2010-07-20 12:34:29,078 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//backdrops/ce1/4bc91004017a3c57fe005ce1/first-blood-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Backgrounds\first-blood-original.jpg; with scale: 1024
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//backdrops/ce1/4bc91004017a3c57fe005ce1/first-blood-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:34:29,078 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//backdrops/cdd/4bc91003017a3c57fe005cdd/first-blood-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Backgrounds\first-blood-original.jpg; WithScale: 1024
2010-07-20 12:34:29,125 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//backdrops/cdd/4bc91003017a3c57fe005cdd/first-blood-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Backgrounds\first-blood-original.jpg; with scale: 1024
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//backdrops/cdd/4bc91003017a3c57fe005cdd/first-blood-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:34:29,125 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//backdrops/cd9/4bc91003017a3c57fe005cd9/first-blood-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Backgrounds\first-blood-original.jpg; WithScale: 1024
2010-07-20 12:34:29,171 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//backdrops/cd9/4bc91003017a3c57fe005cd9/first-blood-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Backgrounds\first-blood-original.jpg; with scale: 1024
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//backdrops/cd9/4bc91003017a3c57fe005cd9/first-blood-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:34:29,171 [23392283@qtp-17346346-4] WARN  sagex.phoenix.fanart.FanartStorage - No BANNER for C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Banners in the metadata.
2010-07-20 12:34:29,171 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://ia.media-imdb.com/images/M/MV5BMTU3MTY1NjI5NF5BMl5BanBnXkFtZTcwOTE0NjY0MQ@@._V1._SX512_SY512_.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Posters\MV5BMTU3MTY1NjI5NF5BMl5BanBnXkFtZTcwOTE0NjY0MQ@@._V1._SX512_SY512_.jpg; WithScale: 200
2010-07-20 12:34:29,578 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Scaling Poster from 374x500 to 200x267
2010-07-20 12:34:29,656 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//posters/cea/4bc91004017a3c57fe005cea/first-blood-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Posters\first-blood-original.jpg; WithScale: 200
2010-07-20 12:34:29,703 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//posters/cea/4bc91004017a3c57fe005cea/first-blood-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Posters\first-blood-original.jpg; with scale: 200
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//posters/cea/4bc91004017a3c57fe005cea/first-blood-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:34:29,703 [23392283@qtp-17346346-4] INFO  sagex.phoenix.metadata.search.SearchUtil - Writing Image; Url: http://hwcdn.themoviedb.org//posters/ce5/4bc91004017a3c57fe005ce5/first-blood-original.jpg; ToFile: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Posters\first-blood-original.jpg; WithScale: 200
2010-07-20 12:34:29,750 [23392283@qtp-17346346-4] WARN  sagex.phoenix.metadata.search.SearchUtil - Failed to write image: http://hwcdn.themoviedb.org//posters/ce5/4bc91004017a3c57fe005ce5/first-blood-original.jpg; to file: C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Posters\first-blood-original.jpg; with scale: 200
java.io.IOException: Server returned HTTP response code: 400 for URL: http://hwcdn.themoviedb.org//posters/ce5/4bc91004017a3c57fe005ce5/first-blood-original.jpg
	at sun.net.www.protocol.http.HttpURLConnection.getInputStream(Unknown Source)
	at sagex.phoenix.metadata.persistence.PersistenceUtil.writeImageFromUrl(PersistenceUtil.java:93)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifact(FanartStorage.java:118)
	at sagex.phoenix.fanart.FanartStorage.downloadFanartArtifacts(FanartStorage.java:95)
	at sagex.phoenix.fanart.FanartStorage.saveCentralFanart(FanartStorage.java:64)
	at sagex.phoenix.fanart.FanartStorage.saveFanart(FanartStorage.java:49)
	at sagex.phoenix.metadata.MetadataManager.updateMetadata(MetadataManager.java:508)
	at org.jdna.bmt.web.server.BrowsingServicesImpl.saveMetadata(BrowsingServicesImpl.java:501)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(Unknown Source)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(Unknown Source)
	at java.lang.reflect.Method.invoke(Unknown Source)
	at com.google.gwt.user.server.rpc.RPC.invokeAndEncodeResponse(RPC.java:562)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processCall(RemoteServiceServlet.java:188)
	at com.google.gwt.user.server.rpc.RemoteServiceServlet.processPost(RemoteServiceServlet.java:224)
	at com.google.gwt.user.server.rpc.AbstractRemoteServiceServlet.doPost(AbstractRemoteServiceServlet.java:62)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:727)
	at javax.servlet.http.HttpServlet.service(HttpServlet.java:820)
	at org.mortbay.jetty.servlet.ServletHolder.handle(ServletHolder.java:502)
	at org.mortbay.jetty.servlet.ServletHandler.handle(ServletHandler.java:389)
	at org.mortbay.jetty.security.SecurityHandler.handle(SecurityHandler.java:216)
	at org.mortbay.jetty.servlet.SessionHandler.handle(SessionHandler.java:181)
	at org.mortbay.jetty.handler.ContextHandler.handle(ContextHandler.java:765)
	at org.mortbay.jetty.webapp.WebAppContext.handle(WebAppContext.java:417)
	at org.mortbay.jetty.handler.ContextHandlerCollection.handle(ContextHandlerCollection.java:230)
	at org.mortbay.jetty.handler.HandlerCollection.handle(HandlerCollection.java:114)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.handler.rewrite.RewriteHandler.handle(RewriteHandler.java:230)
	at org.mortbay.jetty.handler.HandlerWrapper.handle(HandlerWrapper.java:152)
	at org.mortbay.jetty.Server.handle(Server.java:326)
	at org.mortbay.jetty.HttpConnection.handleRequest(HttpConnection.java:534)
	at org.mortbay.jetty.HttpConnection$RequestHandler.content(HttpConnection.java:879)
	at org.mortbay.jetty.HttpParser.parseNext(HttpParser.java:747)
	at org.mortbay.jetty.HttpParser.parseAvailable(HttpParser.java:218)
	at org.mortbay.jetty.HttpConnection.handle(HttpConnection.java:404)
	at org.mortbay.io.nio.SelectChannelEndPoint.run(SelectChannelEndPoint.java:409)
	at org.mortbay.thread.QueuedThreadPool$PoolThread.run(QueuedThreadPool.java:520)
2010-07-20 12:34:29,750 [23392283@qtp-17346346-4] WARN  sagex.phoenix.fanart.FanartStorage - No ACTOR for C:\Documents and Settings\All Users.WINDOWS\Documents\My Fanart\Movies\Rambo First Blood\Actors in the metadata.
2010-07-20 12:34:32,890 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Videos; id: sagedvideos
2010-07-20 12:34:32,906 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Vidoes; id: video
2010-07-20 12:34:32,906 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Vidoes in 0ms
2010-07-20 12:34:32,906 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Vidoes in 0ms
2010-07-20 12:34:32,906 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Videos in 16ms
2010-07-20 12:34:49,578 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Videos; id: sagedvideos
2010-07-20 12:34:49,578 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Creating view for: Vidoes; id: video
2010-07-20 12:34:49,578 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created Source: Vidoes in 0ms
2010-07-20 12:34:49,578 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Vidoes in 0ms
2010-07-20 12:34:49,578 [23392283@qtp-17346346-4] INFO  sagex.phoenix.vfs.views.ViewFactory - Created view: Videos in 0ms