Sep 02, 2018 03:39:20.332 [3748] INFO - Plex Media Scanner v1.13.6.5339-115f087d6 - Microsoft PC x64 - build: windows-i386 - GMT -04:00
Sep 02, 2018 03:39:20.332 [3748] INFO - Windows version: 6.2 (Build 9200), language en-US
Sep 02, 2018 03:39:20.333 [3748] INFO - 16 2994 MHz processor(s): Architecture=0, Level=23, Revision=257 Processor Identifier=AMD64 Family 23 Model 1 Stepping 1, AuthenticAMD
Sep 02, 2018 03:39:20.333 [3748] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 444,65,534,714,5,724,368,179,548,26 --log-file-suffix " Analysis" 
Sep 02, 2018 03:39:20.330 [12160] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Sep 02, 2018 03:39:20.453 [12160] DEBUG - Analyzing media parts for item 444 (The World Is Not Enough): 444
Sep 02, 2018 03:39:20.454 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:20.455 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:20.458 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:20.458 [12160] DEBUG - Updating metadata item (save) (The World Is Not Enough) with ID 444
Sep 02, 2018 03:39:20.464 [12160] DEBUG - [ID 447] Media part analysis: G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi
Sep 02, 2018 03:39:20.465 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi"
Sep 02, 2018 03:39:20.465 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi' for reading
Sep 02, 2018 03:39:20.466 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:20.476 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:20.476 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:20.663 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 9974 bytes read:6768148 seeks:4 nb_streams:2
Sep 02, 2018 03:39:20.666 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:20.666 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:20.666 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 13447 bytes read:6768148 seeks:4 frames:2
Sep 02, 2018 03:39:20.667 [12160] DEBUG - [MI]  * 8dd15c8cbc08ae958a0d9805d41f677016c329b0 [avi mpeg4/ac3] Duration: 7374200ms, 640x272 (2.352941) 25.000fps, bitrate=1447kbps, audio channels=6, optimizedForStreaming=0 ("G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi")
Sep 02, 2018 03:39:20.667 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:20.667 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi"
Sep 02, 2018 03:39:20.668 [12160] DEBUG - [FFMPEG] - Statistics: 6768148 bytes read, 4 seeks
Sep 02, 2018 03:39:20.669 [12160] DEBUG - Committing media stream changes for part 447
Sep 02, 2018 03:39:20.672 [12160] DEBUG - Updating media item 444, size=1334562678, metadata_item_id=444
Sep 02, 2018 03:39:20.672 [12160] DEBUG - Updating part with ID=447 [G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi]
Sep 02, 2018 03:39:20.677 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi"
Sep 02, 2018 03:39:20.677 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi' for reading
Sep 02, 2018 03:39:20.677 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:20.677 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:20.677 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:20.862 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 9974 bytes read:6768148 seeks:4 nb_streams:2
Sep 02, 2018 03:39:20.863 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:20.863 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:20.863 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 13447 bytes read:6768148 seeks:4 frames:2
Sep 02, 2018 03:39:20.863 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\8\dd15c8cbc08ae958a0d9805d41f677016c329b0.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:20.870 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:20.877 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:20.889 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:20.896 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:20.902 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi"
Sep 02, 2018 03:39:20.903 [12160] DEBUG - [FFMPEG] - Statistics: 6833684 bytes read, 6 seeks
Sep 02, 2018 03:39:20.903 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi"
Sep 02, 2018 03:39:20.903 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi' for reading
Sep 02, 2018 03:39:20.904 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:20.904 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:20.904 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:21.073 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 9974 bytes read:6768148 seeks:4 nb_streams:2
Sep 02, 2018 03:39:21.075 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.075 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:21.075 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 13447 bytes read:6768148 seeks:4 frames:2
Sep 02, 2018 03:39:21.075 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\8\dd15c8cbc08ae958a0d9805d41f677016c329b0.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:21.076 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.082 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:21.090 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.097 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:21.103 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\James Bond 007 All Films\James Bond 007 - 21 - The World Is Not Enough (1999).avi"
Sep 02, 2018 03:39:21.104 [12160] DEBUG - [FFMPEG] - Statistics: 6833684 bytes read, 6 seeks
Sep 02, 2018 03:39:21.105 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.105 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.107 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.107 [12160] DEBUG - Updating metadata item (save) (The World Is Not Enough) with ID 444
Sep 02, 2018 03:39:21.114 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=444&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:21.121 [12160] DEBUG - Analyzing media parts for item 65 (Bridget Jones's Baby): 65
Sep 02, 2018 03:39:21.122 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.122 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.124 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.124 [12160] DEBUG - Updating metadata item (save) (Bridget Jones's Baby) with ID 65
Sep 02, 2018 03:39:21.125 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=444&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:21.125 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=444&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:21.127 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=444&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:21.127 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=444&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:21.129 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=444&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:21.130 [12160] DEBUG - [ID 66] Media part analysis: G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi
Sep 02, 2018 03:39:21.131 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi"
Sep 02, 2018 03:39:21.131 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi' for reading
Sep 02, 2018 03:39:21.131 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:21.153 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:21.153 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:21.310 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5809912 seeks:5 nb_streams:2
Sep 02, 2018 03:39:21.318 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.319 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:21.319 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 19206 bytes read:5809912 seeks:5 frames:21
Sep 02, 2018 03:39:21.319 [12160] DEBUG - [MI]  * eb33d17e7ca0721f888d0e326060f0784dc960c9 [avi mpeg4/mp3] Duration: 7359185ms, 640x272 (2.352941) 23.976fps, bitrate=798kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi")
Sep 02, 2018 03:39:21.319 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:21.320 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.320 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.322 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.322 [12160] DEBUG - Updating metadata item (save) (Bridget Jones's Baby) with ID 65
Sep 02, 2018 03:39:21.328 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi"
Sep 02, 2018 03:39:21.329 [12160] DEBUG - [FFMPEG] - Statistics: 5809912 bytes read, 5 seeks
Sep 02, 2018 03:39:21.329 [12160] DEBUG - Committing media stream changes for part 66
Sep 02, 2018 03:39:21.332 [12160] DEBUG - Updating media item 65, size=734251070, metadata_item_id=65
Sep 02, 2018 03:39:21.333 [12160] DEBUG - Updating part with ID=66 [G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi]
Sep 02, 2018 03:39:21.338 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi"
Sep 02, 2018 03:39:21.338 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi' for reading
Sep 02, 2018 03:39:21.338 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:21.338 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:21.338 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:21.488 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5809912 seeks:5 nb_streams:2
Sep 02, 2018 03:39:21.489 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.489 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:21.489 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 19206 bytes read:5809912 seeks:5 frames:21
Sep 02, 2018 03:39:21.489 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\e\b33d17e7ca0721f888d0e326060f0784dc960c9.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:21.496 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.498 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:21.504 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:21.512 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi"
Sep 02, 2018 03:39:21.513 [12160] DEBUG - [FFMPEG] - Statistics: 5908216 bytes read, 6 seeks
Sep 02, 2018 03:39:21.513 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi"
Sep 02, 2018 03:39:21.513 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi' for reading
Sep 02, 2018 03:39:21.513 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:21.514 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:21.514 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:21.662 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5809912 seeks:5 nb_streams:2
Sep 02, 2018 03:39:21.663 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.663 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:21.663 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 19206 bytes read:5809912 seeks:5 frames:21
Sep 02, 2018 03:39:21.663 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\e\b33d17e7ca0721f888d0e326060f0784dc960c9.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:21.664 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.666 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:21.671 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:21.679 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG\Bridget.Jones.Baby.2016.HDRip.XviD-ETRG.avi"
Sep 02, 2018 03:39:21.680 [12160] DEBUG - [FFMPEG] - Statistics: 5908216 bytes read, 6 seeks
Sep 02, 2018 03:39:21.681 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.681 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.692 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.692 [12160] DEBUG - Updating metadata item (save) (Bridget Jones's Baby) with ID 65
Sep 02, 2018 03:39:21.698 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=65&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:21.700 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=65&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:21.700 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=65&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:21.702 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=65&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:21.702 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=65&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:21.704 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=65&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:21.708 [12160] DEBUG - Analyzing media parts for item 534 (Runner Runner): 534
Sep 02, 2018 03:39:21.708 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.709 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.711 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:21.711 [12160] DEBUG - Updating metadata item (save) (Runner Runner) with ID 534
Sep 02, 2018 03:39:21.716 [12160] DEBUG - [ID 542] Media part analysis: G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi
Sep 02, 2018 03:39:21.717 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi"
Sep 02, 2018 03:39:21.717 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi' for reading
Sep 02, 2018 03:39:21.717 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:21.732 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:21.732 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:21.848 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4379312 seeks:5 nb_streams:2
Sep 02, 2018 03:39:21.849 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.849 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:21.849 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 20206 bytes read:4379312 seeks:5 frames:21
Sep 02, 2018 03:39:21.849 [12160] DEBUG - [MI]  * 475f18e823f38ca4fc4f9e15d4b8c24f26b0a64a [avi mpeg4/mp3] Duration: 5499577ms, 640x272 (2.352941) 23.976fps, bitrate=1066kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi")
Sep 02, 2018 03:39:21.850 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:21.850 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi"
Sep 02, 2018 03:39:21.851 [12160] DEBUG - [FFMPEG] - Statistics: 4379312 bytes read, 5 seeks
Sep 02, 2018 03:39:21.851 [12160] DEBUG - Committing media stream changes for part 542
Sep 02, 2018 03:39:21.854 [12160] DEBUG - Updating media item 534, size=733460868, metadata_item_id=534
Sep 02, 2018 03:39:21.855 [12160] DEBUG - Updating part with ID=542 [G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi]
Sep 02, 2018 03:39:21.859 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi"
Sep 02, 2018 03:39:21.860 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi' for reading
Sep 02, 2018 03:39:21.860 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:21.860 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:21.860 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:21.967 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4379312 seeks:5 nb_streams:2
Sep 02, 2018 03:39:21.968 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.968 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:21.968 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 20206 bytes read:4379312 seeks:5 frames:21
Sep 02, 2018 03:39:21.968 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\4\75f18e823f38ca4fc4f9e15d4b8c24f26b0a64a.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:21.975 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:21.977 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:21.983 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:21.991 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi"
Sep 02, 2018 03:39:21.992 [12160] DEBUG - [FFMPEG] - Statistics: 4444848 bytes read, 6 seeks
Sep 02, 2018 03:39:21.992 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi"
Sep 02, 2018 03:39:21.992 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi' for reading
Sep 02, 2018 03:39:21.992 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:21.993 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:21.993 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:22.099 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4379312 seeks:5 nb_streams:2
Sep 02, 2018 03:39:22.099 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.100 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:22.100 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 20206 bytes read:4379312 seeks:5 frames:21
Sep 02, 2018 03:39:22.100 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\4\75f18e823f38ca4fc4f9e15d4b8c24f26b0a64a.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:22.101 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.103 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:22.108 [12160] DEBUG - Loaded memory image of size 640x272.
Sep 02, 2018 03:39:22.115 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Runner Runner [2013]HDRip XviD-SaM[ETRG]\Runner Runner [2013]HDRip XviD-SaM[ETRG].avi"
Sep 02, 2018 03:39:22.116 [12160] DEBUG - [FFMPEG] - Statistics: 4444848 bytes read, 6 seeks
Sep 02, 2018 03:39:22.117 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.117 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.119 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.119 [12160] DEBUG - Updating metadata item (save) (Runner Runner) with ID 534
Sep 02, 2018 03:39:22.125 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=534&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:22.127 [12160] DEBUG - Analyzing media parts for item 714 (D2: The Mighty Ducks): 714
Sep 02, 2018 03:39:22.127 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=534&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:22.127 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=534&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:22.128 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.128 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.129 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=534&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:22.129 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=534&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:22.130 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.130 [12160] DEBUG - Updating metadata item (save) (D2: The Mighty Ducks) with ID 714
Sep 02, 2018 03:39:22.131 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=534&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:22.135 [12160] DEBUG - [ID 725] Media part analysis: G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi
Sep 02, 2018 03:39:22.136 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi"
Sep 02, 2018 03:39:22.136 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi' for reading
Sep 02, 2018 03:39:22.136 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:22.141 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:22.141 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:22.141 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:39:22.322 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6656230 seeks:4 nb_streams:2
Sep 02, 2018 03:39:22.323 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.323 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:22.323 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14574 bytes read:6656230 seeks:4 frames:21
Sep 02, 2018 03:39:22.324 [12160] DEBUG - [MI]  * 6a340256aece2d81cda5fa5f70f7da0307d4e6ea [avi mpeg4/mp3] Duration: 6117280ms, 496x272 (1.823529) 25.000fps, bitrate=960kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi")
Sep 02, 2018 03:39:22.324 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:22.324 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.324 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.326 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.326 [12160] DEBUG - Updating metadata item (save) (D2: The Mighty Ducks) with ID 714
Sep 02, 2018 03:39:22.332 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi"
Sep 02, 2018 03:39:22.333 [12160] DEBUG - [FFMPEG] - Statistics: 6656230 bytes read, 4 seeks
Sep 02, 2018 03:39:22.334 [12160] DEBUG - Committing media stream changes for part 725
Sep 02, 2018 03:39:22.337 [12160] DEBUG - Updating media item 714, size=734580736, metadata_item_id=714
Sep 02, 2018 03:39:22.337 [12160] DEBUG - Updating part with ID=725 [G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi]
Sep 02, 2018 03:39:22.347 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi"
Sep 02, 2018 03:39:22.347 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi' for reading
Sep 02, 2018 03:39:22.347 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:22.347 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:22.348 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:22.348 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:39:22.518 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6656230 seeks:4 nb_streams:2
Sep 02, 2018 03:39:22.519 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.519 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:22.519 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14574 bytes read:6656230 seeks:4 frames:21
Sep 02, 2018 03:39:22.519 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\a340256aece2d81cda5fa5f70f7da0307d4e6ea.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:22.530 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.537 [12160] DEBUG - Loaded memory image of size 496x272.
Sep 02, 2018 03:39:22.543 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi"
Sep 02, 2018 03:39:22.544 [12160] DEBUG - [FFMPEG] - Statistics: 6754534 bytes read, 5 seeks
Sep 02, 2018 03:39:22.544 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi"
Sep 02, 2018 03:39:22.544 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi' for reading
Sep 02, 2018 03:39:22.544 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:22.545 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:22.545 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:22.545 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Sep 02, 2018 03:39:22.714 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6656230 seeks:4 nb_streams:2
Sep 02, 2018 03:39:22.715 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.715 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:22.715 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14574 bytes read:6656230 seeks:4 frames:21
Sep 02, 2018 03:39:22.715 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\a340256aece2d81cda5fa5f70f7da0307d4e6ea.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:22.716 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:22.722 [12160] DEBUG - Loaded memory image of size 496x272.
Sep 02, 2018 03:39:22.730 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\The.Mighty.Ducks.TRiLOGY.DVDRip.XviD-MBC\The.Mighty.Ducks.2.1994.DVDRiP.XViD-MBC\mbc-the.mighty.ducks.2-xvid.avi"
Sep 02, 2018 03:39:22.731 [12160] DEBUG - [FFMPEG] - Statistics: 6754534 bytes read, 5 seeks
Sep 02, 2018 03:39:22.732 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.732 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.734 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.734 [12160] DEBUG - Updating metadata item (save) (D2: The Mighty Ducks) with ID 714
Sep 02, 2018 03:39:22.747 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=714&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:22.748 [12160] DEBUG - Analyzing media parts for item 5 (Planet Earth II - Grasslands): 5
Sep 02, 2018 03:39:22.749 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=714&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:22.749 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=714&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:22.750 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.750 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.751 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=714&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:22.751 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=714&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:22.752 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.752 [12160] DEBUG - Updating metadata item (save) (Planet Earth II - Grasslands) with ID 5
Sep 02, 2018 03:39:22.752 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=714&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:22.763 [12160] DEBUG - [ID 5] Media part analysis: G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4
Sep 02, 2018 03:39:22.763 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4"
Sep 02, 2018 03:39:22.764 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4' for reading
Sep 02, 2018 03:39:22.764 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:22.774 [12160] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 03:39:22.774 [12160] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 02, 2018 03:39:22.774 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:22.792 [12160] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 3000, duration: 87223000
Sep 02, 2018 03:39:22.798 [12160] DEBUG - [FFMPEG] - Offset DTS by 3000 to make first pts zero.
Sep 02, 2018 03:39:22.798 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:22.809 [12160] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 2592, duration: 167467520
Sep 02, 2018 03:39:22.810 [12160] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Sep 02, 2018 03:39:22.810 [12160] DEBUG - [FFMPEG] - drop a frame at curr_cts: 1024 @ 1
Sep 02, 2018 03:39:22.810 [12160] DEBUG - [FFMPEG] - skip 544 audio samples from curr_cts: 2048
Sep 02, 2018 03:39:22.817 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:22.821 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1611926781 bytes read:1847037 seeks:1 nb_streams:3
Sep 02, 2018 03:39:22.824 [12160] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.824 [12160] DEBUG - [FFMPEG] - Decoding VPS
Sep 02, 2018 03:39:22.824 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:22.824 [12160] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.825 [12160] DEBUG - [FFMPEG] - Decoding SPS
Sep 02, 2018 03:39:22.825 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:22.825 [12160] DEBUG - [FFMPEG] - Decoding VUI
Sep 02, 2018 03:39:22.825 [12160] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.825 [12160] DEBUG - [FFMPEG] - Decoding PPS
Sep 02, 2018 03:39:22.827 [12160] DEBUG - [FFMPEG] - demuxer injecting skip 2592 / discard 0
Sep 02, 2018 03:39:22.827 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:22.827 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1925676 bytes read:1978109 seeks:2 frames:14
Sep 02, 2018 03:39:22.828 [12160] DEBUG - [MI] Opening "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4" for MP4 atom parsing
Sep 02, 2018 03:39:22.828 [12160] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 20 at offset 0
Sep 02, 2018 03:39:22.828 [12160] DEBUG - Mp4AtomParser: Found moov atom of size 1823485 at offset 20
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found trak atom of size 1039994 at offset 157
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found trak atom of size 770370 at offset 1040151
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found trak atom of size 12984 at offset 1810521
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found mdia atom of size 1039858 at offset 293
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found minf atom of size 1039760 at offset 391
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found stbl atom of size 1039696 at offset 455
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found mdia atom of size 770234 at offset 1040287
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found minf atom of size 770154 at offset 1040367
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found stbl atom of size 770094 at offset 1040427
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found mdia atom of size 12884 at offset 1810621
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found minf atom of size 12804 at offset 1810701
Sep 02, 2018 03:39:22.829 [12160] DEBUG - Mp4AtomParser: Found stbl atom of size 12748 at offset 1810757
Sep 02, 2018 03:39:22.830 [12160] DEBUG - [MI]  * 07436413ecb1fd19cdb313224cfe322ee0629d12 [mp4 hevc/aac] Duration: 3488920ms, 1920x1080 (1.777778) 25.000fps, bitrate=3696kbps, audio channels=2, optimizedForStreaming=1 ("G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4")
Sep 02, 2018 03:39:22.831 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:22.831 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.831 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.833 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:22.833 [12160] DEBUG - Updating metadata item (save) (Planet Earth II - Grasslands) with ID 5
Sep 02, 2018 03:39:22.838 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4"
Sep 02, 2018 03:39:22.840 [12160] DEBUG - [FFMPEG] - Statistics: 1978109 bytes read, 2 seeks
Sep 02, 2018 03:39:22.840 [12160] DEBUG - Committing media stream changes for part 5
Sep 02, 2018 03:39:22.844 [12160] DEBUG - Updating media item 5, size=1611926825, metadata_item_id=5
Sep 02, 2018 03:39:22.844 [12160] DEBUG - Updating part with ID=5 [G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4]
Sep 02, 2018 03:39:22.854 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4"
Sep 02, 2018 03:39:22.854 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4' for reading
Sep 02, 2018 03:39:22.854 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:22.855 [12160] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 03:39:22.855 [12160] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 02, 2018 03:39:22.855 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:22.862 [12160] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 3000, duration: 87223000
Sep 02, 2018 03:39:22.867 [12160] DEBUG - [FFMPEG] - Offset DTS by 3000 to make first pts zero.
Sep 02, 2018 03:39:22.868 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:22.874 [12160] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 2592, duration: 167467520
Sep 02, 2018 03:39:22.874 [12160] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Sep 02, 2018 03:39:22.874 [12160] DEBUG - [FFMPEG] - drop a frame at curr_cts: 1024 @ 1
Sep 02, 2018 03:39:22.874 [12160] DEBUG - [FFMPEG] - skip 544 audio samples from curr_cts: 2048
Sep 02, 2018 03:39:22.882 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:22.882 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1611926781 bytes read:1847037 seeks:1 nb_streams:3
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - Decoding VPS
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - Decoding SPS
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - Decoding VUI
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.883 [12160] DEBUG - [FFMPEG] - Decoding PPS
Sep 02, 2018 03:39:22.884 [12160] DEBUG - [FFMPEG] - demuxer injecting skip 2592 / discard 0
Sep 02, 2018 03:39:22.885 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:22.885 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1925676 bytes read:1978109 seeks:2 frames:14
Sep 02, 2018 03:39:22.885 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\0\7436413ecb1fd19cdb313224cfe322ee0629d12.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:22.885 [12160] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.885 [12160] DEBUG - [FFMPEG] - Decoding VPS
Sep 02, 2018 03:39:22.885 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:22.885 [12160] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.886 [12160] DEBUG - [FFMPEG] - Decoding SPS
Sep 02, 2018 03:39:22.886 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:22.886 [12160] DEBUG - [FFMPEG] - Decoding VUI
Sep 02, 2018 03:39:22.886 [12160] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.886 [12160] DEBUG - [FFMPEG] - Decoding PPS
Sep 02, 2018 03:39:22.895 [12160] DEBUG - [FFMPEG] - nal_unit_type: 19(IDR_W_RADL), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:22.896 [12160] DEBUG - [FFMPEG] - Format yuv420p10le chosen by get_format().
Sep 02, 2018 03:39:22.962 [12160] DEBUG - [FFMPEG] - Decoded frame with POC 0.
Sep 02, 2018 03:39:22.963 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1(TRAIL_R), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.020 [12160] DEBUG - [FFMPEG] - Decoded frame with POC 4.
Sep 02, 2018 03:39:23.020 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1(TRAIL_R), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.023 [12160] DEBUG - [FFMPEG] - Output frame with POC 0.
Sep 02, 2018 03:39:23.068 [12160] DEBUG - [FFMPEG] - Decoded frame with POC 2.
Sep 02, 2018 03:39:23.148 [12160] DEBUG - Loaded memory image of size 1920x1080.
Sep 02, 2018 03:39:23.183 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4"
Sep 02, 2018 03:39:23.184 [12160] DEBUG - [FFMPEG] - Statistics: 2273175 bytes read, 5 seeks
Sep 02, 2018 03:39:23.184 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4"
Sep 02, 2018 03:39:23.184 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4' for reading
Sep 02, 2018 03:39:23.185 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:23.185 [12160] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 03:39:23.185 [12160] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 02, 2018 03:39:23.185 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:23.192 [12160] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 3000, duration: 87223000
Sep 02, 2018 03:39:23.198 [12160] DEBUG - [FFMPEG] - Offset DTS by 3000 to make first pts zero.
Sep 02, 2018 03:39:23.199 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:23.205 [12160] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 2592, duration: 167467520
Sep 02, 2018 03:39:23.205 [12160] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Sep 02, 2018 03:39:23.205 [12160] DEBUG - [FFMPEG] - drop a frame at curr_cts: 1024 @ 1
Sep 02, 2018 03:39:23.205 [12160] DEBUG - [FFMPEG] - skip 544 audio samples from curr_cts: 2048
Sep 02, 2018 03:39:23.212 [12160] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 03:39:23.213 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1611926781 bytes read:1847037 seeks:1 nb_streams:3
Sep 02, 2018 03:39:23.213 [12160] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.213 [12160] DEBUG - [FFMPEG] - Decoding VPS
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - Decoding SPS
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - Decoding VUI
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.214 [12160] DEBUG - [FFMPEG] - Decoding PPS
Sep 02, 2018 03:39:23.215 [12160] DEBUG - [FFMPEG] - demuxer injecting skip 2592 / discard 0
Sep 02, 2018 03:39:23.215 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:23.215 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1925676 bytes read:1978109 seeks:2 frames:14
Sep 02, 2018 03:39:23.215 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\0\7436413ecb1fd19cdb313224cfe322ee0629d12.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - Decoding VPS
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - Decoding SPS
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - Main 10 profile bitstream
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - Decoding VUI
Sep 02, 2018 03:39:23.216 [12160] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.217 [12160] DEBUG - [FFMPEG] - Decoding PPS
Sep 02, 2018 03:39:23.217 [12160] DEBUG - [FFMPEG] - nal_unit_type: 19(IDR_W_RADL), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.217 [12160] DEBUG - [FFMPEG] - Format yuv420p10le chosen by get_format().
Sep 02, 2018 03:39:23.280 [12160] DEBUG - [FFMPEG] - Decoded frame with POC 0.
Sep 02, 2018 03:39:23.280 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1(TRAIL_R), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.337 [12160] DEBUG - [FFMPEG] - Decoded frame with POC 4.
Sep 02, 2018 03:39:23.337 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1(TRAIL_R), nuh_layer_id: 0, temporal_id: 0
Sep 02, 2018 03:39:23.340 [12160] DEBUG - [FFMPEG] - Output frame with POC 0.
Sep 02, 2018 03:39:23.385 [12160] DEBUG - [FFMPEG] - Decoded frame with POC 2.
Sep 02, 2018 03:39:23.461 [12160] DEBUG - Loaded memory image of size 1920x1080.
Sep 02, 2018 03:39:23.541 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\BBC.Planet.Earth.II.5of6.Grasslands.1080p.HDTV.x265.AAC.MVGroup.org.mp4"
Sep 02, 2018 03:39:23.542 [12160] DEBUG - [FFMPEG] - Statistics: 2273175 bytes read, 5 seeks
Sep 02, 2018 03:39:23.543 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.543 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.545 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.546 [12160] DEBUG - Updating metadata item (save) (Planet Earth II - Grasslands) with ID 5
Sep 02, 2018 03:39:23.557 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:23.559 [12160] DEBUG - Analyzing media parts for item 724 (Three Billboards Outside Ebbing, Missouri): 724
Sep 02, 2018 03:39:23.559 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:23.559 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:23.560 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.560 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.561 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:23.561 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:23.563 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.563 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:23.563 [12160] DEBUG - Updating metadata item (save) (Three Billboards Outside Ebbing, Missouri) with ID 724
Sep 02, 2018 03:39:23.574 [12160] DEBUG - [ID 735] Media part analysis: G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi
Sep 02, 2018 03:39:23.575 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi"
Sep 02, 2018 03:39:23.575 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi' for reading
Sep 02, 2018 03:39:23.575 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:23.587 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:23.587 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:23.762 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6785924 seeks:5 nb_streams:2
Sep 02, 2018 03:39:23.763 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:23.764 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:23.764 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28692 bytes read:6785924 seeks:5 frames:16
Sep 02, 2018 03:39:23.764 [12160] DEBUG - [MI]  * 664903fbc49e4f127d905ef1fa106e1794df2b6d [avi mpeg4/ac3] Duration: 6904097ms, 720x304 (2.368421) 29.970fps, bitrate=1886kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi")
Sep 02, 2018 03:39:23.764 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:23.764 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.765 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.767 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:23.767 [12160] DEBUG - Updating metadata item (save) (Three Billboards Outside Ebbing, Missouri) with ID 724
Sep 02, 2018 03:39:23.778 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi"
Sep 02, 2018 03:39:23.779 [12160] DEBUG - [FFMPEG] - Statistics: 6785924 bytes read, 5 seeks
Sep 02, 2018 03:39:23.779 [12160] DEBUG - Committing media stream changes for part 735
Sep 02, 2018 03:39:23.782 [12160] DEBUG - Updating media item 724, size=1628162048, metadata_item_id=724
Sep 02, 2018 03:39:23.782 [12160] DEBUG - Updating part with ID=735 [G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi]
Sep 02, 2018 03:39:23.787 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi"
Sep 02, 2018 03:39:23.788 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi' for reading
Sep 02, 2018 03:39:23.788 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:23.788 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:23.788 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:23.961 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6785924 seeks:5 nb_streams:2
Sep 02, 2018 03:39:23.963 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:23.963 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:23.963 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28692 bytes read:6785924 seeks:5 frames:16
Sep 02, 2018 03:39:23.963 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\64903fbc49e4f127d905ef1fa106e1794df2b6d.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:23.975 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:23.978 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:23.985 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:24.007 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:24.011 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:24.018 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:24.027 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi"
Sep 02, 2018 03:39:24.028 [12160] DEBUG - [FFMPEG] - Statistics: 7331410 bytes read, 7 seeks
Sep 02, 2018 03:39:24.029 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi"
Sep 02, 2018 03:39:24.029 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi' for reading
Sep 02, 2018 03:39:24.029 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:24.029 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:24.030 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:24.203 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6785924 seeks:5 nb_streams:2
Sep 02, 2018 03:39:24.204 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:24.204 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:24.204 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28692 bytes read:6785924 seeks:5 frames:16
Sep 02, 2018 03:39:24.204 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\6\64903fbc49e4f127d905ef1fa106e1794df2b6d.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:24.205 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:24.208 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:24.215 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:24.222 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:24.226 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:24.233 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:24.241 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies]\Three.Billboards.Outside.Ebbing,Missouri.2017.DVDScr.XVID.AC3.HQ.Hive-CM8[EtMovies].avi"
Sep 02, 2018 03:39:24.244 [12160] DEBUG - [FFMPEG] - Statistics: 7331410 bytes read, 7 seeks
Sep 02, 2018 03:39:24.245 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:24.245 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:24.256 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:24.256 [12160] DEBUG - Updating metadata item (save) (Three Billboards Outside Ebbing, Missouri) with ID 724
Sep 02, 2018 03:39:24.262 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=724&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:24.264 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=724&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:24.264 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=724&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:24.265 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=724&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:24.266 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=724&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:24.267 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=724&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:24.268 [12160] DEBUG - It took 0.000000 ms to retrieve 228 items.
Sep 02, 2018 03:39:24.271 [12160] DEBUG - Analyzing media parts for item 368 (Fantastic Beasts and Where to Find Them): 368
Sep 02, 2018 03:39:24.272 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:24.272 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:24.274 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:24.274 [12160] DEBUG - Updating metadata item (save) (Fantastic Beasts and Where to Find Them) with ID 368
Sep 02, 2018 03:39:24.280 [12160] DEBUG - [ID 369] Media part analysis: G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi
Sep 02, 2018 03:39:24.281 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:39:24.281 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:39:24.281 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:24.299 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:24.299 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:24.858 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:4514096 seeks:73 nb_streams:2
Sep 02, 2018 03:39:24.859 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:24.860 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:24.860 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 77111 bytes read:4514096 seeks:73 frames:7
Sep 02, 2018 03:39:24.860 [12160] DEBUG - [MI]  * c4ba004790d396537c5c6b9e59bba3d401faf2bd [avi mpeg4/ac3] Duration: 7973065ms, 720x304 (2.368421) 29.960fps, bitrate=1500kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi")
Sep 02, 2018 03:39:24.860 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:24.860 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:39:24.861 [12160] DEBUG - [FFMPEG] - Statistics: 4514096 bytes read, 73 seeks
Sep 02, 2018 03:39:24.862 [12160] DEBUG - Committing media stream changes for part 369
Sep 02, 2018 03:39:24.866 [12160] DEBUG - Updating media item 368, size=1495611418, metadata_item_id=368
Sep 02, 2018 03:39:24.866 [12160] DEBUG - Updating part with ID=369 [G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi]
Sep 02, 2018 03:39:24.869 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:39:24.870 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:39:24.870 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:24.870 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:24.870 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:25.291 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:4514096 seeks:73 nb_streams:2
Sep 02, 2018 03:39:25.293 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.293 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:25.293 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 77111 bytes read:4514096 seeks:73 frames:7
Sep 02, 2018 03:39:25.293 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\c\4ba004790d396537c5c6b9e59bba3d401faf2bd.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:25.300 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.311 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:25.324 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.328 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:25.335 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:25.347 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.357 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:25.365 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:39:25.366 [12160] DEBUG - [FFMPEG] - Statistics: 4743472 bytes read, 76 seeks
Sep 02, 2018 03:39:25.367 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:39:25.367 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi' for reading
Sep 02, 2018 03:39:25.367 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:25.368 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:25.368 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:25.792 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:4514096 seeks:73 nb_streams:2
Sep 02, 2018 03:39:25.793 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.794 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:25.794 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 77111 bytes read:4514096 seeks:73 frames:7
Sep 02, 2018 03:39:25.794 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\c\4ba004790d396537c5c6b9e59bba3d401faf2bd.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:25.794 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.805 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:25.812 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.816 [12160] INFO - [FFMPEG] - Video uses a non-standard and wasteful way to store B-frames ('packed B-frames'). Consider using the mpeg4_unpack_bframes bitstream filter without encoding but stream copy to fix it.
Sep 02, 2018 03:39:25.823 [12160] DEBUG - Loaded memory image of size 720x304.
Sep 02, 2018 03:39:25.829 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO\Fantastic.Beasts.and.Where.to.Find.Them.2016.HC.HDRip.XviD.AC3-EVO.avi"
Sep 02, 2018 03:39:25.830 [12160] DEBUG - [FFMPEG] - Statistics: 4677936 bytes read, 75 seeks
Sep 02, 2018 03:39:25.831 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.831 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.833 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.834 [12160] DEBUG - Updating metadata item (save) (Fantastic Beasts and Where to Find Them) with ID 368
Sep 02, 2018 03:39:25.846 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=368&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:25.847 [12160] DEBUG - Analyzing media parts for item 179 (Dbz 075 Password Is Porunga): 179
Sep 02, 2018 03:39:25.848 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.849 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.850 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.851 [12160] DEBUG - Updating metadata item (save) (Dbz 075 Password Is Porunga) with ID 179
Sep 02, 2018 03:39:25.857 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=368&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:25.857 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=368&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:25.859 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=368&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:25.859 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=368&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:25.861 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=368&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:25.873 [12160] DEBUG - [ID 180] Media part analysis: G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv
Sep 02, 2018 03:39:25.874 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv"
Sep 02, 2018 03:39:25.874 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv' for reading
Sep 02, 2018 03:39:25.874 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:25.896 [12160] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:39:25.900 [12160] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.900 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.900 [12160] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.901 [12160] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.901 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5789 bytes read:42315 seeks:2 nb_streams:4
Sep 02, 2018 03:39:25.901 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.902 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.903 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.903 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.903 [12160] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:39:25.903 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:25.904 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.904 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.907 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.907 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.908 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.908 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.909 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.910 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.910 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.911 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.912 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.912 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:25.913 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 21625 bytes read:75083 seeks:2 frames:58
Sep 02, 2018 03:39:25.913 [12160] DEBUG - [MI]  * deb9ee4629fdbd8baba9d19834a4823d9116b30a [mkv h264/aac] Duration: 1146562ms, 720x384 (1.875000) 23.976fps, bitrate=369kbps, audio channels=1, optimizedForStreaming=0 ("G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv")
Sep 02, 2018 03:39:25.913 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:25.913 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.913 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.916 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:25.916 [12160] DEBUG - Updating metadata item (save) (Dbz 075 Password Is Porunga) with ID 179
Sep 02, 2018 03:39:25.924 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv"
Sep 02, 2018 03:39:25.925 [12160] DEBUG - [FFMPEG] - Statistics: 75083 bytes read, 2 seeks
Sep 02, 2018 03:39:25.925 [12160] DEBUG - Committing media stream changes for part 180
Sep 02, 2018 03:39:25.935 [12160] DEBUG - Updating media item 179, size=52898506, metadata_item_id=179
Sep 02, 2018 03:39:25.935 [12160] DEBUG - Updating part with ID=180 [G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv]
Sep 02, 2018 03:39:25.940 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv"
Sep 02, 2018 03:39:25.940 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv' for reading
Sep 02, 2018 03:39:25.940 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:25.940 [12160] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:39:25.941 [12160] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.941 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.941 [12160] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.941 [12160] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.941 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5789 bytes read:42315 seeks:2 nb_streams:4
Sep 02, 2018 03:39:25.942 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.942 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.943 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.943 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.944 [12160] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:39:25.944 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:25.944 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.944 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.947 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.947 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.947 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.948 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.949 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.949 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.950 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.951 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.951 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.952 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:25.952 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 21625 bytes read:75083 seeks:2 frames:58
Sep 02, 2018 03:39:25.952 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\d\eb9ee4629fdbd8baba9d19834a4823d9116b30a.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:25.953 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.953 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.963 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.963 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.963 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:25.963 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.964 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.966 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.966 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.967 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.977 [12160] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:39:25.988 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv"
Sep 02, 2018 03:39:25.989 [12160] DEBUG - [FFMPEG] - Statistics: 154422 bytes read, 5 seeks
Sep 02, 2018 03:39:25.990 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv"
Sep 02, 2018 03:39:25.990 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv' for reading
Sep 02, 2018 03:39:25.990 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:25.991 [12160] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:39:25.991 [12160] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.991 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.991 [12160] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.991 [12160] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:25.991 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5789 bytes read:42315 seeks:2 nb_streams:4
Sep 02, 2018 03:39:25.992 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.992 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.993 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:25.993 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:25.994 [12160] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:39:25.994 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:25.994 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:25.994 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.997 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.997 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:25.997 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:25.998 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:25.999 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:26.000 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.000 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.001 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.002 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 03:39:26.002 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.002 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 21625 bytes read:75083 seeks:2 frames:58
Sep 02, 2018 03:39:26.002 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\d\eb9ee4629fdbd8baba9d19834a4823d9116b30a.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:26.003 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.003 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.004 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.004 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.004 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:26.004 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.005 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.007 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.007 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.008 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.018 [12160] DEBUG - Loaded memory image of size 720x384.
Sep 02, 2018 03:39:26.029 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Dragonball Z Remastered Seasons 1-9 + Movies Pack\Dragon Ball Z Remastered Season 3 [Triple-Audio]\DBZ - 075 - Password is Porunga.mkv"
Sep 02, 2018 03:39:26.030 [12160] DEBUG - [FFMPEG] - Statistics: 154422 bytes read, 5 seeks
Sep 02, 2018 03:39:26.032 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.032 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.034 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.034 [12160] DEBUG - Updating metadata item (save) (Dbz 075 Password Is Porunga) with ID 179
Sep 02, 2018 03:39:26.040 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=179&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:26.046 [12160] DEBUG - Analyzing media parts for item 548 (Source Code): 548
Sep 02, 2018 03:39:26.046 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.047 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.049 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.049 [12160] DEBUG - Updating metadata item (save) (Source Code) with ID 548
Sep 02, 2018 03:39:26.051 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=179&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:26.051 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=179&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:26.053 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=179&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:26.053 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=179&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:26.054 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=179&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:26.055 [12160] DEBUG - [ID 556] Media part analysis: G:\Movies Home\Source Code\Source Code.avi
Sep 02, 2018 03:39:26.055 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Source Code\Source Code.avi"
Sep 02, 2018 03:39:26.056 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Source Code\Source Code.avi' for reading
Sep 02, 2018 03:39:26.056 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:26.068 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:26.069 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:26.182 [12160] DEBUG - [FFMPEG] - overriding invalid dshow_block_align of 1
Sep 02, 2018 03:39:26.184 [12160] INFO - [FFMPEG] - non-interleaved AVI
Sep 02, 2018 03:39:26.184 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:2361600 seeks:45 nb_streams:2
Sep 02, 2018 03:39:26.185 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.186 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.186 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 70740 bytes read:2361600 seeks:45 frames:2
Sep 02, 2018 03:39:26.186 [12160] DEBUG - [MI]  * 93835c8c6d90816789810271041988a9de59d2b8 [avi mpeg4/mp2] Duration: 5590010ms, 720x400 (1.800000) 23.976fps, bitrate=2093kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\Source Code\Source Code.avi")
Sep 02, 2018 03:39:26.186 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:26.186 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Source Code\Source Code.avi"
Sep 02, 2018 03:39:26.187 [12160] DEBUG - [FFMPEG] - Statistics: 2361600 bytes read, 45 seeks
Sep 02, 2018 03:39:26.187 [12160] DEBUG - Committing media stream changes for part 556
Sep 02, 2018 03:39:26.190 [12160] DEBUG - Updating media item 548, size=1462533036, metadata_item_id=548
Sep 02, 2018 03:39:26.190 [12160] DEBUG - Updating part with ID=556 [G:\Movies Home\Source Code\Source Code.avi]
Sep 02, 2018 03:39:26.195 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Source Code\Source Code.avi"
Sep 02, 2018 03:39:26.195 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Source Code\Source Code.avi' for reading
Sep 02, 2018 03:39:26.195 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:26.195 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:26.195 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:26.222 [12160] DEBUG - [FFMPEG] - overriding invalid dshow_block_align of 1
Sep 02, 2018 03:39:26.223 [12160] INFO - [FFMPEG] - non-interleaved AVI
Sep 02, 2018 03:39:26.224 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:2361600 seeks:45 nb_streams:2
Sep 02, 2018 03:39:26.225 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.225 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.225 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 70740 bytes read:2361600 seeks:45 frames:2
Sep 02, 2018 03:39:26.225 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\9\3835c8c6d90816789810271041988a9de59d2b8.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:26.229 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.242 [12160] DEBUG - Loaded memory image of size 720x400.
Sep 02, 2018 03:39:26.252 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Source Code\Source Code.avi"
Sep 02, 2018 03:39:26.253 [12160] DEBUG - [FFMPEG] - Statistics: 2427136 bytes read, 46 seeks
Sep 02, 2018 03:39:26.253 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\Source Code\Source Code.avi"
Sep 02, 2018 03:39:26.253 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\Source Code\Source Code.avi' for reading
Sep 02, 2018 03:39:26.253 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:26.253 [12160] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Sep 02, 2018 03:39:26.253 [12160] DEBUG - [FFMPEG] - use odml:1
Sep 02, 2018 03:39:26.280 [12160] DEBUG - [FFMPEG] - overriding invalid dshow_block_align of 1
Sep 02, 2018 03:39:26.282 [12160] INFO - [FFMPEG] - non-interleaved AVI
Sep 02, 2018 03:39:26.283 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 65536 bytes read:2361600 seeks:45 nb_streams:2
Sep 02, 2018 03:39:26.283 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.284 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.284 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 70740 bytes read:2361600 seeks:45 frames:2
Sep 02, 2018 03:39:26.284 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\9\3835c8c6d90816789810271041988a9de59d2b8.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:26.285 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.297 [12160] DEBUG - Loaded memory image of size 720x400.
Sep 02, 2018 03:39:26.311 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\Source Code\Source Code.avi"
Sep 02, 2018 03:39:26.311 [12160] DEBUG - [FFMPEG] - Statistics: 2427136 bytes read, 46 seeks
Sep 02, 2018 03:39:26.312 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.312 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.314 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.314 [12160] DEBUG - Updating metadata item (save) (Source Code) with ID 548
Sep 02, 2018 03:39:26.326 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=548&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:26.328 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=548&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:26.328 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=548&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:26.329 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=548&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:26.330 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=548&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:26.330 [12160] DEBUG - Analyzing media parts for item 26 (A Prophet): 26
Sep 02, 2018 03:39:26.331 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=548&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:26.331 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.331 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.333 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.333 [12160] DEBUG - Updating metadata item (save) (A Prophet) with ID 26
Sep 02, 2018 03:39:26.339 [12160] DEBUG - [ID 26] Media part analysis: G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv
Sep 02, 2018 03:39:26.340 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv"
Sep 02, 2018 03:39:26.340 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv' for reading
Sep 02, 2018 03:39:26.340 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:26.357 [12160] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:39:26.357 [12160] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.358 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5980 bytes read:32768 seeks:0 nb_streams:8
Sep 02, 2018 03:39:26.359 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.359 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:26.361 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.362 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.364 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.365 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.366 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.368 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.370 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.372 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.373 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.374 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.375 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.377 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.377 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 26108 bytes read:32768 seeks:0 frames:34
Sep 02, 2018 03:39:26.377 [12160] DEBUG - [MI]  * 844bf64c8b25481633eef43e65d338aacea02465 [mkv h264/aac] Duration: 9304085ms, 1280x688 (1.860465) 24.000fps, bitrate=642kbps, audio channels=2, optimizedForStreaming=0 ("G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv")
Sep 02, 2018 03:39:26.377 [12160] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 03:39:26.378 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv"
Sep 02, 2018 03:39:26.379 [12160] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Sep 02, 2018 03:39:26.379 [12160] DEBUG - Committing media stream changes for part 26
Sep 02, 2018 03:39:26.388 [12160] DEBUG - Updating media item 26, size=746671940, metadata_item_id=26
Sep 02, 2018 03:39:26.388 [12160] DEBUG - Updating part with ID=26 [G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv]
Sep 02, 2018 03:39:26.399 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv"
Sep 02, 2018 03:39:26.399 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv' for reading
Sep 02, 2018 03:39:26.399 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:26.399 [12160] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.400 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5980 bytes read:32768 seeks:0 nb_streams:8
Sep 02, 2018 03:39:26.401 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.401 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:26.403 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.404 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.406 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.408 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.409 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.411 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.412 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.414 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.416 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.417 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.418 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.419 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.420 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 26108 bytes read:32768 seeks:0 frames:34
Sep 02, 2018 03:39:26.420 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\8\44bf64c8b25481633eef43e65d338aacea02465.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Sep 02, 2018 03:39:26.420 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.420 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.433 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.433 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.433 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.433 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.434 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:26.434 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.435 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.438 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.439 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.441 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.472 [12160] DEBUG - Loaded memory image of size 1280x688.
Sep 02, 2018 03:39:26.493 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv"
Sep 02, 2018 03:39:26.495 [12160] DEBUG - [FFMPEG] - Statistics: 102200 bytes read, 3 seeks
Sep 02, 2018 03:39:26.495 [12160] DEBUG - [MI] Opening input file: "G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv"
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - Opening 'G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv' for reading
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.496 [12160] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.497 [12160] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.497 [12160] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.497 [12160] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Sep 02, 2018 03:39:26.497 [12160] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5980 bytes read:32768 seeks:0 nb_streams:8
Sep 02, 2018 03:39:26.497 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.497 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.499 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.499 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.500 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.500 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.500 [12160] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 03:39:26.500 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:26.500 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.501 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.503 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.504 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.505 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.506 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.508 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.510 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.512 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.513 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.514 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.515 [12160] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 03:39:26.515 [12160] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 26108 bytes read:32768 seeks:0 frames:34
Sep 02, 2018 03:39:26.515 [12160] DEBUG - Creating C:\Users\Ross Klos\AppData\Local\Plex Media Server\Media\localhost\8\44bf64c8b25481633eef43e65d338aacea02465.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Sep 02, 2018 03:39:26.516 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.516 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.519 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.519 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.519 [12160] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 03:39:26.519 [12160] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 03:39:26.519 [12160] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 03:39:26.519 [12160] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 03:39:26.520 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.524 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.525 [12160] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 03:39:26.527 [12160] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 03:39:26.558 [12160] DEBUG - Loaded memory image of size 1280x688.
Sep 02, 2018 03:39:26.600 [12160] DEBUG - [MI] Closing input file: "G:\Movies Home\A Prophet\A Prophet [2009] 720p.mkv"
Sep 02, 2018 03:39:26.602 [12160] DEBUG - [FFMPEG] - Statistics: 102200 bytes read, 3 seeks
Sep 02, 2018 03:39:26.603 [12160] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.603 [12160] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.605 [12160] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 03:39:26.605 [12160] DEBUG - Updating metadata item (save) (A Prophet) with ID 26
Sep 02, 2018 03:39:26.616 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=26&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:26.618 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=26&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 03:39:26.618 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=26&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:26.620 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=26&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 03:39:26.620 [21284] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=26&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 03:39:26.621 [21284] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=26&metadataType=1&state=-1&mediaState=idle
