Oct 27, 2018 02:20:49.740 [5672] INFO - Plex Media Scanner v1.13.8.5395-10d48da0d - Microsoft PC x64 - build: windows-i386 - GMT 01:00
Oct 27, 2018 02:20:49.740 [5672] INFO - Windows version: 6.2 (Build 9200), language en-US
Oct 27, 2018 02:20:49.740 [5672] INFO - 4 1896 MHz processor(s): Architecture=0, Level=6, Revision=17665 Processor Identifier=Intel64 Family 6 Model 69 Stepping 1, GenuineIntel
Oct 27, 2018 02:20:49.740 [5672] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 122238,122161,122399,122459,139176,122116,122464,122468,122085,122277 --log-file-suffix " Analysis" 
Oct 27, 2018 02:20:49.724 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:49.724 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\aac_decoder.dll
Oct 27, 2018 02:20:49.724 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\ac3_decoder.dll
Oct 27, 2018 02:20:49.724 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\ac3_encoder.dll
Oct 27, 2018 02:20:49.724 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\amrnb_decoder.dll
Oct 27, 2018 02:20:49.724 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\dca_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\h263_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\h264_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\libmp3lame_encoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\libx264_encoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\mp1_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\mp2_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\mp3_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\mpeg1video_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\mpeg2video_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\mpeg4_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\msmpeg4v3_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] VERBOSE - [FFMPEG] - Loading external lib C:\Users\craig\AppData\Local\Plex Media Server\Codecs\e7828f1-1324-windows-i386\wmav2_decoder.dll
Oct 27, 2018 02:20:49.740 [6440] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Oct 27, 2018 02:20:49.959 [6440] DEBUG - Analyzing media parts for item 122238 (The Rite): 111433
Oct 27, 2018 02:20:49.975 [6440] DEBUG - [ID 115004] Media part analysis: \\network2\video\Movies\The Rite (2011).avi
Oct 27, 2018 02:20:50.021 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Rite (2011).avi"
Oct 27, 2018 02:20:50.021 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Rite (2011).avi' for reading
Oct 27, 2018 02:20:50.021 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:50.053 [6440] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:50.053 [6440] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:50.053 [6440] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Oct 27, 2018 02:20:51.162 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:7297114 seeks:4 nb_streams:2
Oct 27, 2018 02:20:51.162 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:51.162 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:51.162 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:51.178 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:51.178 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14655 bytes read:7297114 seeks:4 frames:22
Oct 27, 2018 02:20:51.178 [6440] DEBUG - [MI]  * da87a6e41b4db6d041e25479f63a436380d69de2 [avi mpeg4/mp3] Duration: 6821315ms, 640x272 (2.352941) 23.976fps, bitrate=850kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Movies\The Rite (2011).avi")
Oct 27, 2018 02:20:51.178 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:51.178 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Rite (2011).avi"
Oct 27, 2018 02:20:51.178 [6440] DEBUG - [FFMPEG] - Statistics: 7297114 bytes read, 4 seeks
Oct 27, 2018 02:20:51.178 [6440] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:51.178 [6440] DEBUG - Updating media item 111433, size=725596160, metadata_item_id=122238
Oct 27, 2018 02:20:51.225 [6440] DEBUG - Updating part with ID=115004 [\\network2\video\Movies\The Rite (2011).avi]
Oct 27, 2018 02:20:51.287 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122238&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:51.303 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122238&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:51.303 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122238&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:51.318 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122238&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:51.318 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122238&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:51.318 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122238&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:51.318 [6440] DEBUG - It took 15.625000 ms to retrieve 165 items.
Oct 27, 2018 02:20:51.365 [6440] DEBUG - Analyzing media parts for item 122161 (Star Trek Into Darkness): 111356
Oct 27, 2018 02:20:51.365 [6440] DEBUG - [ID 114927] Media part analysis: \\network2\video\Movies\Star Trek Into Darkness (2013).mp4
Oct 27, 2018 02:20:51.412 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Star Trek Into Darkness (2013).mp4"
Oct 27, 2018 02:20:51.412 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Star Trek Into Darkness (2013).mp4' for reading
Oct 27, 2018 02:20:51.412 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:51.459 [6440] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:51.459 [6440] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:51.459 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:51.584 [6440] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:51.600 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:51.662 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 967620045 bytes read:4095614 seeks:1 nb_streams:2
Oct 27, 2018 02:20:51.662 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:51.662 [6440] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:51.662 [6440] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:51.662 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:51.678 [6440] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:51.678 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:51.693 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:51.709 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4068146 bytes read:4128382 seeks:2 frames:13
Oct 27, 2018 02:20:51.709 [6440] DEBUG - [MI] Opening "\\network2\video\Movies\Star Trek Into Darkness (2013).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found moov atom of size 4066343 at offset 24
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 2306033 at offset 161
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 1760173 at offset 2306194
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 2305933 at offset 261
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 2305799 at offset 395
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 2305735 at offset 459
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 1760073 at offset 2306294
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 1759978 at offset 2306389
Oct 27, 2018 02:20:51.709 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 1759918 at offset 2306449
Oct 27, 2018 02:20:51.709 [6440] DEBUG - [MI]  * e06f50b792644b2b74c7f3a96495bc3a490cdde6 [mp4 h264/aac] Duration: 7925917ms, 1280x534 (2.397004) 23.976fps, bitrate=976kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\Star Trek Into Darkness (2013).mp4")
Oct 27, 2018 02:20:51.709 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:51.709 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Star Trek Into Darkness (2013).mp4"
Oct 27, 2018 02:20:51.725 [6440] DEBUG - [FFMPEG] - Statistics: 4128382 bytes read, 2 seeks
Oct 27, 2018 02:20:51.725 [6440] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:51.725 [6440] DEBUG - Updating media item 111356, size=967620072, metadata_item_id=122161
Oct 27, 2018 02:20:51.740 [6440] DEBUG - Updating part with ID=114927 [\\network2\video\Movies\Star Trek Into Darkness (2013).mp4]
Oct 27, 2018 02:20:51.788 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122161&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:51.788 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122161&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:51.803 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122161&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:51.819 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122161&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:51.819 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122161&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:51.819 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122161&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:51.835 [6440] DEBUG - Analyzing media parts for item 122399 (Cats & Dogs): 111498
Oct 27, 2018 02:20:51.835 [6440] DEBUG - [ID 115069] Media part analysis: \\network2\video\Childrens\Cats & Dogs.avi
Oct 27, 2018 02:20:51.835 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\Cats && Dogs.avi"
Oct 27, 2018 02:20:51.835 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\Cats & Dogs.avi' for reading
Oct 27, 2018 02:20:51.835 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:51.881 [6440] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:51.881 [6440] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:52.256 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 8854 bytes read:5213680 seeks:4 nb_streams:2
Oct 27, 2018 02:20:52.256 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:52.256 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:52.256 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:52.256 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:52.256 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 11881 bytes read:5213680 seeks:4 frames:3
Oct 27, 2018 02:20:52.256 [6440] DEBUG - [MI]  * a8c22366d1946845d6bd5d87f2afdadbf9e39c1d [avi mpeg4/mp3] Duration: 5019873ms, 640x360 (1.777778) 25.000fps, bitrate=1339kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Childrens\Cats && Dogs.avi")
Oct 27, 2018 02:20:52.272 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:52.272 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\Cats && Dogs.avi"
Oct 27, 2018 02:20:52.272 [6440] DEBUG - [FFMPEG] - Statistics: 5213680 bytes read, 4 seeks
Oct 27, 2018 02:20:52.272 [6440] DEBUG - Updating media item 111498, size=840570778, metadata_item_id=122399
Oct 27, 2018 02:20:52.272 [6440] DEBUG - Updating part with ID=115069 [\\network2\video\Childrens\Cats & Dogs.avi]
Oct 27, 2018 02:20:52.350 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122399&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:52.366 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122399&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:52.366 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122399&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:52.381 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122399&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:52.381 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122399&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:52.397 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122399&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:52.413 [6440] DEBUG - Analyzing media parts for item 122459 (Oliver & Company): 111558
Oct 27, 2018 02:20:52.413 [6440] DEBUG - [ID 115129] Media part analysis: \\network2\video\Childrens\Oliver & Company.avi
Oct 27, 2018 02:20:52.413 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\Oliver && Company.avi"
Oct 27, 2018 02:20:52.413 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\Oliver & Company.avi' for reading
Oct 27, 2018 02:20:52.413 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:52.428 [6440] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:52.428 [6440] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 9910 bytes read:4646896 seeks:4 nb_streams:2
Oct 27, 2018 02:20:52.741 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:52.741 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 13648 bytes read:4646896 seeks:4 frames:3
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [MI]  * 9bc9f61437f28d46e3750958d66c716f47700c89 [avi mpeg4/mp3] Duration: 4233600ms, 640x480 (1.777778) 25.000fps, bitrate=1313kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Childrens\Oliver && Company.avi")
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:52.741 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\Oliver && Company.avi"
Oct 27, 2018 02:20:52.756 [6440] DEBUG - [FFMPEG] - Statistics: 4646896 bytes read, 4 seeks
Oct 27, 2018 02:20:52.756 [6440] DEBUG - Updating media item 111558, size=694858474, metadata_item_id=122459
Oct 27, 2018 02:20:52.756 [6440] DEBUG - Updating part with ID=115129 [\\network2\video\Childrens\Oliver & Company.avi]
Oct 27, 2018 02:20:52.835 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122459&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:52.835 [6440] DEBUG - Analyzing media parts for item 139176 (IMG_0716): 125966
Oct 27, 2018 02:20:52.835 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122459&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:52.835 [6440] DEBUG - [ID 129538] Media part analysis: \\network2\photo\2003\2003 clumber park\thomas neil bday\IMG_0716.JPG
Oct 27, 2018 02:20:52.835 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122459&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:52.850 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122459&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:52.850 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122459&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:52.866 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122459&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:52.929 [6440] ERROR - Format [JPEG] - Not a JPEG file: starts with 0x00 0x00
Oct 27, 2018 02:20:52.929 [6440] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:52.929 [6440] DEBUG - Updating media item 125966, size=3104827, metadata_item_id=139176
Oct 27, 2018 02:20:52.944 [6440] DEBUG - Updating part with ID=129538 [\\network2\photo\2003\2003 clumber park\thomas neil bday\IMG_0716.JPG]
Oct 27, 2018 02:20:53.007 [6440] ERROR - Format [JPEG] - Not a JPEG file: starts with 0x00 0x00
Oct 27, 2018 02:20:53.007 [6440] DEBUG - Creating C:\Users\craig\AppData\Local\Plex Media Server\Media\localhost\5\699adef6802037a73f018257c78c355eb24d74a.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Oct 27, 2018 02:20:53.022 [6440] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:53.022 [6440] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:53.022 [6440] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:53.022 [6440] DEBUG - Updating metadata item (save) (IMG_0716) with ID 139176
Oct 27, 2018 02:20:53.085 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139176&metadataType=13&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:53.085 [6440] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/services/imagga/process/139176
Oct 27, 2018 02:20:53.100 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139176&metadataType=13&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:53.100 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139176&metadataType=13&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:53.100 [6440] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/services/imagga/process/139176
Oct 27, 2018 02:20:53.116 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139176&metadataType=13&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:53.116 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139176&metadataType=13&state=-1&mediaState=idle
Oct 27, 2018 02:20:53.132 [6440] DEBUG - Analyzing media parts for item 122116 (Old School): 111311
Oct 27, 2018 02:20:53.132 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139176&metadataType=13&state=-1&mediaState=idle
Oct 27, 2018 02:20:53.132 [6440] DEBUG - [ID 114881] Media part analysis: \\network2\video\Movies\Old School (2003).avi
Oct 27, 2018 02:20:53.179 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Old School (2003).avi"
Oct 27, 2018 02:20:53.179 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Old School (2003).avi' for reading
Oct 27, 2018 02:20:53.179 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:53.225 [6440] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:53.225 [6440] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:53.225 [6440] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:5953196 seeks:5 nb_streams:2
Oct 27, 2018 02:20:53.616 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:53.616 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 18893 bytes read:5953196 seeks:5 frames:21
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [MI]  * d1ab4153b4539e7ec8020874bf03597f06724734 [avi mpeg4/mp3] Duration: 5511595ms, 608x256 (2.375000) 23.976fps, bitrate=1065kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Movies\Old School (2003).avi")
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Old School (2003).avi"
Oct 27, 2018 02:20:53.616 [6440] DEBUG - [FFMPEG] - Statistics: 5953196 bytes read, 5 seeks
Oct 27, 2018 02:20:53.616 [6440] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:53.632 [6440] DEBUG - Updating media item 111311, size=734220288, metadata_item_id=122116
Oct 27, 2018 02:20:53.663 [6440] DEBUG - Updating part with ID=114881 [\\network2\video\Movies\Old School (2003).avi]
Oct 27, 2018 02:20:53.725 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122116&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:53.741 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122116&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:53.741 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122116&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:53.757 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122116&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:53.757 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122116&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:53.772 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122116&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:53.772 [6440] DEBUG - Analyzing media parts for item 122464 (Penguins of Madagascar): 111563
Oct 27, 2018 02:20:53.788 [6440] DEBUG - [ID 115134] Media part analysis: \\network2\video\Childrens\Penguins of Madagascar.mp4
Oct 27, 2018 02:20:53.788 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\Penguins of Madagascar.mp4"
Oct 27, 2018 02:20:53.788 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\Penguins of Madagascar.mp4' for reading
Oct 27, 2018 02:20:53.788 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:53.819 [6440] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:53.819 [6440] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:53.819 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:53.913 [6440] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:53.913 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 786804571 bytes read:2832302 seeks:1 nb_streams:2
Oct 27, 2018 02:20:53.975 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:53.975 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:53.975 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:53.975 [6440] VERBOSE - [FFMPEG] - Reinit context to 1280x704, pix_fmt: yuv420p
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:53.991 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:54.007 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:54.022 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2816369 bytes read:2865070 seeks:2 frames:13
Oct 27, 2018 02:20:54.022 [6440] DEBUG - [MI] Opening "\\network2\video\Childrens\Penguins of Madagascar.mp4" for MP4 atom parsing
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found moov atom of size 2814751 at offset 24
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 1590593 at offset 161
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 1224021 at offset 1590754
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 1590493 at offset 261
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 1590359 at offset 395
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 1590295 at offset 459
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 1223921 at offset 1590854
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 1223826 at offset 1590949
Oct 27, 2018 02:20:54.022 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 1223766 at offset 1591009
Oct 27, 2018 02:20:54.022 [6440] DEBUG - [MI]  * f811ccf840219e142d6e6d369538135c343d4c90 [mp4 h264/aac] Duration: 5539617ms, 1280x690 (1.855072) 23.976fps, bitrate=1136kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Childrens\Penguins of Madagascar.mp4")
Oct 27, 2018 02:20:54.022 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:54.022 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\Penguins of Madagascar.mp4"
Oct 27, 2018 02:20:54.038 [6440] DEBUG - [FFMPEG] - Statistics: 2865070 bytes read, 2 seeks
Oct 27, 2018 02:20:54.038 [6440] DEBUG - Updating media item 111563, size=786804598, metadata_item_id=122464
Oct 27, 2018 02:20:54.038 [6440] DEBUG - Updating part with ID=115134 [\\network2\video\Childrens\Penguins of Madagascar.mp4]
Oct 27, 2018 02:20:54.147 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122464&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:54.163 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122464&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:54.163 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122464&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:54.163 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122464&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:54.179 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122464&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:54.179 [6440] DEBUG - Analyzing media parts for item 122468 (Pinocchio): 111567
Oct 27, 2018 02:20:54.194 [6440] DEBUG - [ID 115138] Media part analysis: \\network2\video\Childrens\Pinocchio.avi
Oct 27, 2018 02:20:54.194 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\Pinocchio.avi"
Oct 27, 2018 02:20:54.194 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\Pinocchio.avi' for reading
Oct 27, 2018 02:20:54.194 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:54.194 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122464&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:54.225 [6440] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:54.225 [6440] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:54.491 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4166378 seeks:4 nb_streams:2
Oct 27, 2018 02:20:54.491 [6440] VERBOSE - [FFMPEG] - parser not found for codec msmpeg4v3, packets or times may be invalid.
Oct 27, 2018 02:20:54.491 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:54.491 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:54.491 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:54.507 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:54.507 [6440] VERBOSE - [FFMPEG] - parser not found for codec msmpeg4v3, packets or times may be invalid.
Oct 27, 2018 02:20:54.507 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:54.507 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14343 bytes read:4166378 seeks:4 frames:18
Oct 27, 2018 02:20:54.507 [6440] DEBUG - [MI]  * 118cc7a104c3b11900897cecbbf00ac73e264a5d [avi msmpeg4v3/mp3] Duration: 5044000ms, 720x416 (1.730769) 25.000fps, bitrate=1155kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Childrens\Pinocchio.avi")
Oct 27, 2018 02:20:54.507 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:54.507 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\Pinocchio.avi"
Oct 27, 2018 02:20:54.507 [6440] DEBUG - [FFMPEG] - Statistics: 4166378 bytes read, 4 seeks
Oct 27, 2018 02:20:54.507 [6440] DEBUG - Updating media item 111567, size=728352768, metadata_item_id=122468
Oct 27, 2018 02:20:54.507 [6440] DEBUG - Updating part with ID=115138 [\\network2\video\Childrens\Pinocchio.avi]
Oct 27, 2018 02:20:54.569 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122468&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:54.569 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122468&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:54.585 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122468&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:54.600 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122468&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:54.600 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122468&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:54.616 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122468&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:54.632 [6440] DEBUG - Analyzing media parts for item 122085 (Let Me In): 111280
Oct 27, 2018 02:20:54.632 [6440] DEBUG - [ID 114849] Media part analysis: \\network2\video\Movies\Let Me In (2010).avi
Oct 27, 2018 02:20:54.679 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Let Me In (2010).avi"
Oct 27, 2018 02:20:54.679 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Let Me In (2010).avi' for reading
Oct 27, 2018 02:20:54.679 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:54.757 [6440] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:54.757 [6440] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6819056 seeks:5 nb_streams:2
Oct 27, 2018 02:20:55.851 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:55.851 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 19078 bytes read:6819056 seeks:5 frames:20
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [MI]  * b49d3c84a0f9b68a2f056967bf0bd13ef16105e5 [avi mpeg4/mp3] Duration: 6939239ms, 720x304 (2.368421) 29.970fps, bitrate=1801kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Movies\Let Me In (2010).avi")
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Let Me In (2010).avi"
Oct 27, 2018 02:20:55.851 [6440] DEBUG - [FFMPEG] - Statistics: 6819056 bytes read, 5 seeks
Oct 27, 2018 02:20:55.851 [6440] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:55.851 [6440] DEBUG - Updating media item 111280, size=1562427392, metadata_item_id=122085
Oct 27, 2018 02:20:55.851 [6440] DEBUG - Updating part with ID=114849 [\\network2\video\Movies\Let Me In (2010).avi]
Oct 27, 2018 02:20:55.898 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122085&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:55.914 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122085&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:55.914 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122085&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:55.929 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122085&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:55.929 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122085&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:55.929 [6440] DEBUG - It took 15.625000 ms to retrieve 125 items.
Oct 27, 2018 02:20:55.929 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122085&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:55.960 [6440] DEBUG - Analyzing media parts for item 122277 (X-Men: First Class): 111472
Oct 27, 2018 02:20:55.976 [6440] DEBUG - [ID 115043] Media part analysis: \\network2\video\Movies\X First Class (2011).mp4
Oct 27, 2018 02:20:56.023 [6440] DEBUG - [MI] Opening input file: "\\network2\video\Movies\X First Class (2011).mp4"
Oct 27, 2018 02:20:56.023 [6440] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\X First Class (2011).mp4' for reading
Oct 27, 2018 02:20:56.023 [6440] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:56.070 [6440] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:56.070 [6440] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Oct 27, 2018 02:20:56.070 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:56.195 [6440] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:56.195 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:56.226 [6440] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:56.273 [6440] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 2151673280 bytes read:5862733 seeks:1 nb_streams:3
Oct 27, 2018 02:20:56.273 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:56.273 [6440] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:56.273 [6440] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:56.273 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:56.273 [6440] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:56.273 [6440] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:56.273 [6440] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:56.273 [6440] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:56.273 [6440] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.289 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.304 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.304 [6440] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:56.304 [6440] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:56.304 [6440] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 5841373 bytes read:5895501 seeks:2 frames:37
Oct 27, 2018 02:20:56.304 [6440] DEBUG - [MI] Opening "\\network2\video\Movies\X First Class (2011).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:56.304 [6440] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Oct 27, 2018 02:20:56.304 [6440] DEBUG - Mp4AtomParser: Found moov atom of size 5833341 at offset 28
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 2322753 at offset 165
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 1755266 at offset 2322918
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found trak atom of size 1755058 at offset 4078184
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 2322653 at offset 265
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 2322558 at offset 360
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 2322494 at offset 424
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 1755166 at offset 2323018
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 1755071 at offset 2323113
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 1755011 at offset 2323173
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found mdia atom of size 1754958 at offset 4078284
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found minf atom of size 1754863 at offset 4078379
Oct 27, 2018 02:20:56.320 [6440] DEBUG - Mp4AtomParser: Found stbl atom of size 1754803 at offset 4078439
Oct 27, 2018 02:20:56.320 [6440] DEBUG - [MI]  * dd7607f020660b7e84abd580765ef39f58e72fbd [mp4 h264/aac] Duration: 7903020ms, 1280x544 (2.352941) 23.976fps, bitrate=2178kbps, audio channels=6, optimizedForStreaming=1 ("\\network2\video\Movies\X First Class (2011).mp4")
Oct 27, 2018 02:20:56.320 [6440] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:56.320 [6440] DEBUG - [MI] Closing input file: "\\network2\video\Movies\X First Class (2011).mp4"
Oct 27, 2018 02:20:56.335 [6440] DEBUG - [FFMPEG] - Statistics: 5895501 bytes read, 2 seeks
Oct 27, 2018 02:20:56.335 [6440] DEBUG - Committing media stream changes for part 115043
Oct 27, 2018 02:20:56.429 [6440] DEBUG - Updating media item 111472, size=2151673355, metadata_item_id=122277
Oct 27, 2018 02:20:56.445 [6440] DEBUG - Updating part with ID=115043 [\\network2\video\Movies\X First Class (2011).mp4]
Oct 27, 2018 02:20:56.492 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122277&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:56.492 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122277&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:56.492 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122277&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:56.507 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122277&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:56.507 [8328] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122277&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:56.507 [8328] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122277&metadataType=1&state=-1&mediaState=idle
