Oct 27, 2018 02:20:03.711 [11248] INFO - Plex Media Scanner v1.13.8.5395-10d48da0d - Microsoft PC x64 - build: windows-i386 - GMT 01:00
Oct 27, 2018 02:20:03.711 [11248] INFO - Windows version: 6.2 (Build 9200), language en-US
Oct 27, 2018 02:20:03.711 [11248] 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:03.711 [11248] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 122137,122086,122177,121935,139020,122203,139187,122220,122445,122512 --log-file-suffix " Analysis" 
Oct 27, 2018 02:20:03.696 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:03.696 [7712] 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:03.696 [7712] 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:03.696 [7712] 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:03.696 [7712] 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:03.696 [7712] 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:03.696 [7712] 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:03.696 [7712] 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:03.696 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] 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:03.711 [7712] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Oct 27, 2018 02:20:03.899 [7712] DEBUG - It took 0.000000 ms to retrieve 132 items.
Oct 27, 2018 02:20:03.930 [7712] DEBUG - Analyzing media parts for item 122137 (RED 2): 111332
Oct 27, 2018 02:20:03.930 [7712] DEBUG - [ID 114903] Media part analysis: \\network2\video\Movies\RED 2 (2013).mp4
Oct 27, 2018 02:20:03.962 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Movies\RED 2 (2013).mp4"
Oct 27, 2018 02:20:03.962 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\RED 2 (2013).mp4' for reading
Oct 27, 2018 02:20:03.962 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:04.024 [7712] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:04.024 [7712] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:04.024 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:04.133 [7712] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:04.133 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 910037100 bytes read:3603165 seeks:1 nb_streams:2
Oct 27, 2018 02:20:04.180 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:04.180 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:04.180 [7712] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:04.180 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:04.196 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3599725 bytes read:3635933 seeks:2 frames:13
Oct 27, 2018 02:20:04.212 [7712] DEBUG - [MI] Opening "\\network2\video\Movies\RED 2 (2013).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found moov atom of size 3598154 at offset 24
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 2054600 at offset 161
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 1543417 at offset 2054761
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 2054500 at offset 261
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 2054366 at offset 395
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 2054302 at offset 459
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 1543317 at offset 2054861
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 1543222 at offset 2054956
Oct 27, 2018 02:20:04.212 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 1543162 at offset 2055016
Oct 27, 2018 02:20:04.227 [7712] DEBUG - [MI]  * 97d2720f020b366e206bbebca3b662672fba9dc5 [mp4 h264/aac] Duration: 6949013ms, 1280x536 (2.388060) 23.976fps, bitrate=1047kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\RED 2 (2013).mp4")
Oct 27, 2018 02:20:04.227 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:04.227 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Movies\RED 2 (2013).mp4"
Oct 27, 2018 02:20:04.227 [7712] DEBUG - [FFMPEG] - Statistics: 3635933 bytes read, 2 seeks
Oct 27, 2018 02:20:04.227 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:04.227 [7712] DEBUG - Updating media item 111332, size=910037127, metadata_item_id=122137
Oct 27, 2018 02:20:04.243 [7712] DEBUG - Updating part with ID=114903 [\\network2\video\Movies\RED 2 (2013).mp4]
Oct 27, 2018 02:20:04.258 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122137&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:04.274 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122137&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:04.274 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122137&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:04.274 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122137&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:04.274 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122137&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:04.290 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122137&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:04.305 [7712] DEBUG - Analyzing media parts for item 122086 (Life of Brian): 111281
Oct 27, 2018 02:20:04.305 [7712] DEBUG - [ID 114850] Media part analysis: \\network2\video\Movies\Life of Brian (1979).avi
Oct 27, 2018 02:20:04.368 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Life of Brian (1979).avi"
Oct 27, 2018 02:20:04.368 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Life of Brian (1979).avi' for reading
Oct 27, 2018 02:20:04.368 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:04.399 [7712] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:04.399 [7712] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:04.399 [7712] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Oct 27, 2018 02:20:04.399 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 2048 bytes read:32768 seeks:2 nb_streams:2
Oct 27, 2018 02:20:04.399 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:04.415 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:04.415 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:04.415 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:04.430 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 6360 bytes read:65536 seeks:2 frames:4
Oct 27, 2018 02:20:04.430 [7712] DEBUG - [MI]  * 1b825e6385d0d4a38c6a2813bd8a5ddfa447e2fa [avi mpeg4/mp3] Duration: 0ms, 688x416 (1.653846) 25.000fps, bitrate=0kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Movies\Life of Brian (1979).avi")
Oct 27, 2018 02:20:04.430 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:04.430 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Life of Brian (1979).avi"
Oct 27, 2018 02:20:04.430 [7712] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 2 seeks
Oct 27, 2018 02:20:04.430 [7712] DEBUG - Committing media stream changes for part 114850
Oct 27, 2018 02:20:04.446 [7712] DEBUG - Updating media item 111281, size=584535786, metadata_item_id=122086
Oct 27, 2018 02:20:04.477 [7712] DEBUG - Updating part with ID=114850 [\\network2\video\Movies\Life of Brian (1979).avi]
Oct 27, 2018 02:20:04.509 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122086&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:04.524 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122086&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:04.524 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122086&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:04.540 [7712] DEBUG - It took 15.625000 ms to retrieve 178 items.
Oct 27, 2018 02:20:04.540 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122086&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:04.540 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122086&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:04.555 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122086&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:04.571 [7712] DEBUG - Analyzing media parts for item 122177 (Superman): 111372
Oct 27, 2018 02:20:04.571 [7712] DEBUG - [ID 114943] Media part analysis: \\network2\video\Movies\Superman (1978).mp4
Oct 27, 2018 02:20:04.602 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Superman (1978).mp4"
Oct 27, 2018 02:20:04.602 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Superman (1978).mp4' for reading
Oct 27, 2018 02:20:04.602 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:04.633 [7712] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:04.633 [7712] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:04.633 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:04.805 [7712] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:04.805 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 791021187 bytes read:3104487 seeks:1 nb_streams:2
Oct 27, 2018 02:20:04.837 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:04.837 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:04.837 [7712] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:04.837 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:04.852 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.852 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.852 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.852 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.852 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.868 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:04.868 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:04.868 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3082362 bytes read:3137255 seeks:2 frames:13
Oct 27, 2018 02:20:04.868 [7712] DEBUG - [MI] Opening "\\network2\video\Movies\Superman (1978).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found moov atom of size 3081080 at offset 24
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 2088644 at offset 161
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 992299 at offset 2088805
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 2088544 at offset 261
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 2088470 at offset 335
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 2088406 at offset 399
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 992199 at offset 2088905
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 992104 at offset 2089000
Oct 27, 2018 02:20:04.868 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 992044 at offset 2089060
Oct 27, 2018 02:20:04.868 [7712] DEBUG - [MI]  * af8fd3eca33f25af889fa76397690a58ae31b00e [mp4 h264/aac] Duration: 8597717ms, 1280x534 (2.397004) 23.976fps, bitrate=736kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\Superman (1978).mp4")
Oct 27, 2018 02:20:04.883 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:04.883 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Superman (1978).mp4"
Oct 27, 2018 02:20:04.899 [7712] DEBUG - [FFMPEG] - Statistics: 3137255 bytes read, 2 seeks
Oct 27, 2018 02:20:04.899 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:04.899 [7712] DEBUG - Updating media item 111372, size=791021218, metadata_item_id=122177
Oct 27, 2018 02:20:04.899 [7712] DEBUG - Updating part with ID=114943 [\\network2\video\Movies\Superman (1978).mp4]
Oct 27, 2018 02:20:04.946 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122177&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:04.946 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122177&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:04.946 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122177&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:04.962 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122177&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:04.962 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122177&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:04.962 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122177&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:04.977 [7712] DEBUG - Analyzing media parts for item 121935 (A Very Harold & Kumar Christmas): 111130
Oct 27, 2018 02:20:04.977 [7712] DEBUG - [ID 114699] Media part analysis: \\network2\video\Movies\A Very Harold & Kumar Christmas (2011).mp4
Oct 27, 2018 02:20:05.024 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Movies\A Very Harold && Kumar Christmas (2011).mp4"
Oct 27, 2018 02:20:05.024 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\A Very Harold & Kumar Christmas (2011).mp4' for reading
Oct 27, 2018 02:20:05.024 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:05.055 [7712] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:05.055 [7712] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:05.055 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:05.165 [7712] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:05.165 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 630264563 bytes read:2222635 seeks:1 nb_streams:2
Oct 27, 2018 02:20:05.180 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:05.180 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:05.180 [7712] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.180 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.196 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:05.212 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:05.212 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2205598 bytes read:2255403 seeks:2 frames:13
Oct 27, 2018 02:20:05.212 [7712] DEBUG - [MI] Opening "\\network2\video\Movies\A Very Harold && Kumar Christmas (2011).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found moov atom of size 2203944 at offset 24
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 1582764 at offset 161
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 621043 at offset 1582925
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 1582664 at offset 261
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 1582591 at offset 334
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 1582527 at offset 398
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 620943 at offset 1583025
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 620848 at offset 1583120
Oct 27, 2018 02:20:05.212 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 620788 at offset 1583180
Oct 27, 2018 02:20:05.212 [7712] DEBUG - [MI]  * 268dc17c996c932aec1cc43bd36e5c81feebe156 [mp4 h264/aac] Duration: 5380522ms, 1280x536 (2.388060) 23.976fps, bitrate=937kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\A Very Harold && Kumar Christmas (2011).mp4")
Oct 27, 2018 02:20:05.212 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:05.212 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Movies\A Very Harold && Kumar Christmas (2011).mp4"
Oct 27, 2018 02:20:05.227 [7712] DEBUG - [FFMPEG] - Statistics: 2255403 bytes read, 2 seeks
Oct 27, 2018 02:20:05.227 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:05.227 [7712] DEBUG - Updating media item 111130, size=630264594, metadata_item_id=121935
Oct 27, 2018 02:20:05.243 [7712] DEBUG - Updating part with ID=114699 [\\network2\video\Movies\A Very Harold & Kumar Christmas (2011).mp4]
Oct 27, 2018 02:20:05.430 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121935&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:05.446 [7712] DEBUG - Analyzing media parts for item 139020 (flowers march08 003): 125818
Oct 27, 2018 02:20:05.446 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121935&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:05.446 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121935&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:05.446 [7712] DEBUG - [ID 129390] Media part analysis: \\network2\photo\2003\2003 clumber park\2008-03-10 flowers march08\flowers march08 003.JPG
Oct 27, 2018 02:20:05.446 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121935&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:05.446 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121935&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:05.462 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121935&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:05.540 [7712] ERROR - Format [JPEG] - Not a JPEG file: starts with 0x00 0x00
Oct 27, 2018 02:20:05.540 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:05.540 [7712] DEBUG - Updating media item 125818, size=2776866, metadata_item_id=139020
Oct 27, 2018 02:20:05.555 [7712] DEBUG - Updating part with ID=129390 [\\network2\photo\2003\2003 clumber park\2008-03-10 flowers march08\flowers march08 003.JPG]
Oct 27, 2018 02:20:05.587 [7712] ERROR - Format [JPEG] - Not a JPEG file: starts with 0x00 0x00
Oct 27, 2018 02:20:05.587 [7712] DEBUG - Creating C:\Users\craig\AppData\Local\Plex Media Server\Media\localhost\3\ae7c44a6099b9a7b30741b7f640555b2061224f.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Oct 27, 2018 02:20:05.602 [7712] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:05.602 [7712] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:05.602 [7712] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:05.602 [7712] DEBUG - Updating metadata item (save) (flowers march08 003) with ID 139020
Oct 27, 2018 02:20:05.649 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139020&metadataType=13&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:05.649 [7712] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/services/imagga/process/139020
Oct 27, 2018 02:20:05.649 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139020&metadataType=13&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:05.649 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139020&metadataType=13&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:05.665 [7712] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/services/imagga/process/139020
Oct 27, 2018 02:20:05.680 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139020&metadataType=13&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:05.680 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139020&metadataType=13&state=-1&mediaState=idle
Oct 27, 2018 02:20:05.680 [7712] DEBUG - It took 15.625000 ms to retrieve 116 items.
Oct 27, 2018 02:20:05.696 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139020&metadataType=13&state=-1&mediaState=idle
Oct 27, 2018 02:20:05.727 [7712] DEBUG - Analyzing media parts for item 122203 (The Hobbit: An Unexpected Journey): 111398
Oct 27, 2018 02:20:05.727 [7712] DEBUG - [ID 114969] Media part analysis: \\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4
Oct 27, 2018 02:20:05.774 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4"
Oct 27, 2018 02:20:05.790 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4' for reading
Oct 27, 2018 02:20:05.790 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:05.821 [7712] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:05.821 [7712] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:05.821 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:06.024 [7712] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:06.024 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1394320272 bytes read:4862028 seeks:1 nb_streams:2
Oct 27, 2018 02:20:06.087 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:06.087 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:06.087 [7712] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:06.087 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:06.102 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:06.102 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:06.102 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:06.102 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:06.102 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:06.102 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:06.118 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:06.118 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:06.118 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:06.118 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:06.118 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4853696 bytes read:4894796 seeks:2 frames:13
Oct 27, 2018 02:20:06.118 [7712] DEBUG - [MI] Opening "\\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:06.118 [7712] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:06.118 [7712] DEBUG - Mp4AtomParser: Found moov atom of size 4852385 at offset 24
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 2591962 at offset 161
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 2260286 at offset 2592123
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 2591862 at offset 261
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 2591681 at offset 442
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 2591617 at offset 506
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 2260186 at offset 2592223
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 2260094 at offset 2592315
Oct 27, 2018 02:20:06.134 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 2260034 at offset 2592375
Oct 27, 2018 02:20:06.134 [7712] DEBUG - [MI]  * b36aca71ff38951912f0bc57678ffaf4adab01ee [mp4 h264/aac] Duration: 10177173ms, 1280x536 (2.388060) 23.976fps, bitrate=1096kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4")
Oct 27, 2018 02:20:06.134 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:06.134 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4"
Oct 27, 2018 02:20:06.149 [7712] DEBUG - [FFMPEG] - Statistics: 4894796 bytes read, 2 seeks
Oct 27, 2018 02:20:06.149 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:06.149 [7712] DEBUG - Updating media item 111398, size=1394320307, metadata_item_id=122203
Oct 27, 2018 02:20:06.196 [7712] DEBUG - Updating part with ID=114969 [\\network2\video\Movies\The Hobbit - An Unexpected Journey (2012).mp4]
Oct 27, 2018 02:20:06.556 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122203&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:06.571 [7712] DEBUG - Analyzing media parts for item 139187 (IMG_0730): 125977
Oct 27, 2018 02:20:06.571 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122203&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:06.571 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122203&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:06.571 [7712] DEBUG - [ID 129549] Media part analysis: \\network2\photo\2003\2003 clumber park\thomas neil bday\IMG_0730.JPG
Oct 27, 2018 02:20:06.587 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122203&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:06.587 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122203&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:06.587 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122203&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:06.696 [7712] ERROR - Format [JPEG] - Not a JPEG file: starts with 0x00 0x00
Oct 27, 2018 02:20:06.696 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:06.696 [7712] DEBUG - Updating media item 125977, size=3111159, metadata_item_id=139187
Oct 27, 2018 02:20:06.727 [7712] DEBUG - Updating part with ID=129549 [\\network2\photo\2003\2003 clumber park\thomas neil bday\IMG_0730.JPG]
Oct 27, 2018 02:20:06.821 [7712] ERROR - Format [JPEG] - Not a JPEG file: starts with 0x00 0x00
Oct 27, 2018 02:20:06.821 [7712] DEBUG - Creating C:\Users\craig\AppData\Local\Plex Media Server\Media\localhost\2\8b988d93cd3ce973a75f0d93a527439d5e8fdd4.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Oct 27, 2018 02:20:06.821 [7712] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:06.821 [7712] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:06.837 [7712] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Oct 27, 2018 02:20:06.837 [7712] DEBUG - Updating metadata item (save) (IMG_0730) with ID 139187
Oct 27, 2018 02:20:06.884 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139187&metadataType=13&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:06.884 [7712] DEBUG - HTTP requesting PUT http://127.0.0.1:32400/services/imagga/process/139187
Oct 27, 2018 02:20:06.884 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139187&metadataType=13&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:06.899 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139187&metadataType=13&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:06.899 [7712] DEBUG - HTTP 200 response from PUT http://127.0.0.1:32400/services/imagga/process/139187
Oct 27, 2018 02:20:06.899 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139187&metadataType=13&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:06.899 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139187&metadataType=13&state=-1&mediaState=idle
Oct 27, 2018 02:20:06.899 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=18&metadataItemID=139187&metadataType=13&state=-1&mediaState=idle
Oct 27, 2018 02:20:06.931 [7712] DEBUG - It took 15.625000 ms to retrieve 130 items.
Oct 27, 2018 02:20:06.962 [7712] DEBUG - Analyzing media parts for item 122220 (The Lone Ranger): 111415
Oct 27, 2018 02:20:06.962 [7712] DEBUG - [ID 114986] Media part analysis: \\network2\video\Movies\The Lone Ranger (2013).mp4
Oct 27, 2018 02:20:07.009 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Lone Ranger (2013).mp4"
Oct 27, 2018 02:20:07.009 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Lone Ranger (2013).mp4' for reading
Oct 27, 2018 02:20:07.009 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:07.071 [7712] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:07.071 [7712] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:20:07.071 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:07.259 [7712] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:07.274 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1035289455 bytes read:4661105 seeks:1 nb_streams:2
Oct 27, 2018 02:20:07.337 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:07.337 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:07.337 [7712] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:07.337 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:20:07.352 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:07.368 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4642822 bytes read:4693873 seeks:2 frames:13
Oct 27, 2018 02:20:07.368 [7712] DEBUG - [MI] Opening "\\network2\video\Movies\The Lone Ranger (2013).mp4" for MP4 atom parsing
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found moov atom of size 4640970 at offset 24
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 2647952 at offset 161
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 1992881 at offset 2648113
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 2647852 at offset 261
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 2647718 at offset 395
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 2647654 at offset 459
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 1992781 at offset 2648213
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 1992686 at offset 2648308
Oct 27, 2018 02:20:07.368 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 1992626 at offset 2648368
Oct 27, 2018 02:20:07.368 [7712] DEBUG - [MI]  * 1e579d8975f5cb2b2e611ecae64ff7e09315e39c [mp4 h264/aac] Duration: 8973077ms, 1280x534 (2.397004) 23.976fps, bitrate=923kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Lone Ranger (2013).mp4")
Oct 27, 2018 02:20:07.368 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:07.368 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Lone Ranger (2013).mp4"
Oct 27, 2018 02:20:07.384 [7712] DEBUG - [FFMPEG] - Statistics: 4693873 bytes read, 2 seeks
Oct 27, 2018 02:20:07.384 [7712] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:20:07.384 [7712] DEBUG - Updating media item 111415, size=1035289482, metadata_item_id=122220
Oct 27, 2018 02:20:07.431 [7712] DEBUG - Updating part with ID=114986 [\\network2\video\Movies\The Lone Ranger (2013).mp4]
Oct 27, 2018 02:20:07.478 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122220&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:07.493 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122220&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:07.493 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122220&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:07.509 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122220&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:07.509 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122220&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:07.524 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122220&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:07.540 [7712] DEBUG - Analyzing media parts for item 122445 (Madagascar 3: Europe's Most Wanted): 111544
Oct 27, 2018 02:20:07.556 [7712] DEBUG - [ID 115115] Media part analysis: \\network2\video\Childrens\Madagascar 3.m4v
Oct 27, 2018 02:20:07.556 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\Madagascar 3.m4v"
Oct 27, 2018 02:20:07.556 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\Madagascar 3.m4v' for reading
Oct 27, 2018 02:20:07.556 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:07.587 [7712] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:20:07.602 [7712] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Oct 27, 2018 02:20:07.602 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:07.681 [7712] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 10800, duration: 504464400
Oct 27, 2018 02:20:07.696 [7712] DEBUG - [FFMPEG] - Offset DTS by 10800 to make first pts zero.
Oct 27, 2018 02:20:07.727 [7712] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:20:07.743 [7712] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1068674601 bytes read:2956621 seeks:2 nb_streams:2
Oct 27, 2018 02:20:07.775 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:20:07.775 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:07.775 [7712] VERBOSE - [FFMPEG] - Reinit context to 704x592, pix_fmt: yuv420p
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1141 bytes read:2989389 seeks:3 frames:9
Oct 27, 2018 02:20:07.775 [7712] DEBUG - [MI] Opening "\\network2\video\Childrens\Madagascar 3.m4v" for MP4 atom parsing
Oct 27, 2018 02:20:07.775 [7712] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Oct 27, 2018 02:20:07.775 [7712] DEBUG - Mp4AtomParser: Skipping free atom of size 132 at offset 28
Oct 27, 2018 02:20:07.775 [7712] DEBUG - Mp4AtomParser: Skipping mdat atom of size 1065633225 at offset 160
Oct 27, 2018 02:20:07.775 [7712] DEBUG - Mp4AtomParser: Found moov atom of size 3041192 at offset 1065633385
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 1858167 at offset 1065633525
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found trak atom of size 1182774 at offset 1067491692
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 1858031 at offset 1065633625
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 1857958 at offset 1065633698
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 1857894 at offset 1065633762
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found mdia atom of size 1182652 at offset 1067491792
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found minf atom of size 1182579 at offset 1067491865
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Mp4AtomParser: Found stbl atom of size 1182519 at offset 1067491925
Oct 27, 2018 02:20:07.790 [7712] DEBUG - [MI]  * 42abfbe46417100da0ca226b560798766af65bdd [mp4 h264/aac] Duration: 5605160ms, 704x588 (1.737374) 25.000fps, bitrate=1525kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Childrens\Madagascar 3.m4v")
Oct 27, 2018 02:20:07.790 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:07.790 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\Madagascar 3.m4v"
Oct 27, 2018 02:20:07.790 [7712] DEBUG - [FFMPEG] - Statistics: 2989389 bytes read, 3 seeks
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Updating media item 111544, size=1068674709, metadata_item_id=122445
Oct 27, 2018 02:20:07.790 [7712] DEBUG - Updating part with ID=115115 [\\network2\video\Childrens\Madagascar 3.m4v]
Oct 27, 2018 02:20:07.869 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122445&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:07.884 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122445&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:07.884 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122445&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:07.900 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122445&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:07.900 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122445&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:07.900 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122445&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:07.900 [7712] DEBUG - It took 0.000000 ms to retrieve 101 items.
Oct 27, 2018 02:20:07.931 [7712] DEBUG - Analyzing media parts for item 122512 (The Lion King): 111611
Oct 27, 2018 02:20:07.931 [7712] DEBUG - [ID 115183] Media part analysis: \\network2\video\Childrens\The Lion King.avi
Oct 27, 2018 02:20:07.931 [7712] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\The Lion King.avi"
Oct 27, 2018 02:20:07.931 [7712] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\The Lion King.avi' for reading
Oct 27, 2018 02:20:07.931 [7712] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:20:07.962 [7712] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:20:07.962 [7712] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:3098792 seeks:5 nb_streams:2
Oct 27, 2018 02:20:08.181 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:08.181 [7712] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 18228 bytes read:3098792 seeks:5 frames:4
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [MI]  * 3352e198db0fff748463f8a066138e8341e1cadb [avi mpeg4/ac3] Duration: 5333328ms, 608x368 (1.652174) 23.976fps, bitrate=1174kbps, audio channels=6, optimizedForStreaming=0 ("\\network2\video\Childrens\The Lion King.avi")
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\The Lion King.avi"
Oct 27, 2018 02:20:08.181 [7712] DEBUG - [FFMPEG] - Statistics: 3098792 bytes read, 5 seeks
Oct 27, 2018 02:20:08.181 [7712] DEBUG - Updating media item 111611, size=782684160, metadata_item_id=122512
Oct 27, 2018 02:20:08.197 [7712] DEBUG - Updating part with ID=115183 [\\network2\video\Childrens\The Lion King.avi]
Oct 27, 2018 02:20:08.228 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122512&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:08.244 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122512&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:20:08.244 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122512&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:08.244 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122512&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:20:08.244 [8464] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122512&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:20:08.244 [8464] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122512&metadataType=1&state=-1&mediaState=idle
