Oct 27, 2018 02:21:32.361 [10560] INFO - Plex Media Scanner v1.13.8.5395-10d48da0d - Microsoft PC x64 - build: windows-i386 - GMT 01:00
Oct 27, 2018 02:21:32.361 [10560] INFO - Windows version: 6.2 (Build 9200), language en-US
Oct 27, 2018 02:21:32.361 [10560] 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:21:32.361 [10560] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 122183,122127,122494,122429,122205,121950,122242,122520,122221,122471 --log-file-suffix " Analysis" 
Oct 27, 2018 02:21:32.346 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:32.346 [10292] 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:21:32.346 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] 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:21:32.361 [10292] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Oct 27, 2018 02:21:32.564 [10292] DEBUG - Analyzing media parts for item 122183 (The Adventurer: The Curse of the Midas Box): 111378
Oct 27, 2018 02:21:32.564 [10292] DEBUG - [ID 114949] Media part analysis: \\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4
Oct 27, 2018 02:21:32.611 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4"
Oct 27, 2018 02:21:32.611 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4' for reading
Oct 27, 2018 02:21:32.611 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:32.658 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:32.658 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:32.658 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:32.783 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:32.783 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:32.830 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 793254206 bytes read:3098848 seeks:1 nb_streams:2
Oct 27, 2018 02:21:32.830 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:32.830 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:32.830 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:32.830 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:32.846 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:32.846 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3086884 bytes read:3131616 seeks:2 frames:13
Oct 27, 2018 02:21:32.862 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4" for MP4 atom parsing
Oct 27, 2018 02:21:32.862 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:32.862 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 3085297 at offset 24
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1759147 at offset 161
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1326013 at offset 1759308
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1759047 at offset 261
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1758909 at offset 399
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1758845 at offset 463
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1325913 at offset 1759408
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1325818 at offset 1759503
Oct 27, 2018 02:21:32.877 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1325758 at offset 1759563
Oct 27, 2018 02:21:32.877 [10292] DEBUG - [MI]  * f66ee5a56d6585e13c73cf3fc08ec5ab2576bc04 [mp4 h264/aac] Duration: 5970027ms, 1280x544 (2.352941) 23.976fps, bitrate=1062kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4")
Oct 27, 2018 02:21:32.877 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:32.877 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4"
Oct 27, 2018 02:21:32.877 [10292] DEBUG - [FFMPEG] - Statistics: 3131616 bytes read, 2 seeks
Oct 27, 2018 02:21:32.893 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:32.893 [10292] DEBUG - Updating media item 111378, size=793254237, metadata_item_id=122183
Oct 27, 2018 02:21:32.893 [10292] DEBUG - Updating part with ID=114949 [\\network2\video\Movies\The Adventurer The Curse of the Midas Box (2013).mp4]
Oct 27, 2018 02:21:32.955 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122183&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:32.971 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122183&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:32.971 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122183&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:32.986 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122183&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:32.986 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122183&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:32.986 [10292] DEBUG - It took 31.250000 ms to retrieve 195 items.
Oct 27, 2018 02:21:32.986 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122183&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:33.018 [10292] DEBUG - Analyzing media parts for item 122127 (Pitch Perfect): 111322
Oct 27, 2018 02:21:33.033 [10292] DEBUG - [ID 114893] Media part analysis: \\network2\video\Movies\Pitch Perfect (2012).mp4
Oct 27, 2018 02:21:33.065 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Pitch Perfect (2012).mp4"
Oct 27, 2018 02:21:33.065 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Pitch Perfect (2012).mp4' for reading
Oct 27, 2018 02:21:33.065 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:33.096 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:33.096 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:33.096 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:33.190 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:33.190 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 837429363 bytes read:3232270 seeks:1 nb_streams:2
Oct 27, 2018 02:21:33.268 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:33.268 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:33.268 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x688, pix_fmt: yuv420p
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:33.268 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:33.283 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.283 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.283 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.299 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.299 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.299 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.299 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:33.299 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3226695 bytes read:3265038 seeks:2 frames:13
Oct 27, 2018 02:21:33.299 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\Pitch Perfect (2012).mp4" for MP4 atom parsing
Oct 27, 2018 02:21:33.299 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:33.299 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 3225319 at offset 24
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1731021 at offset 161
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1494161 at offset 1731182
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1730921 at offset 261
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1730848 at offset 334
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1730784 at offset 398
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1494061 at offset 1731282
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1493966 at offset 1731377
Oct 27, 2018 02:21:33.315 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1493906 at offset 1731437
Oct 27, 2018 02:21:33.315 [10292] DEBUG - [MI]  * 558e9d4435b5e0ecdb1af79512ebac23b3718e7e [mp4 h264/aac] Duration: 6727232ms, 1280x688 (1.860465) 23.976fps, bitrate=995kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\Pitch Perfect (2012).mp4")
Oct 27, 2018 02:21:33.315 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:33.315 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Pitch Perfect (2012).mp4"
Oct 27, 2018 02:21:33.315 [10292] DEBUG - [FFMPEG] - Statistics: 3265038 bytes read, 2 seeks
Oct 27, 2018 02:21:33.330 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:33.330 [10292] DEBUG - Updating media item 111322, size=837429394, metadata_item_id=122127
Oct 27, 2018 02:21:33.330 [10292] DEBUG - Updating part with ID=114893 [\\network2\video\Movies\Pitch Perfect (2012).mp4]
Oct 27, 2018 02:21:33.393 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122127&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:33.393 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122127&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:33.408 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122127&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:33.408 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122127&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:33.408 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122127&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:33.424 [10292] DEBUG - It took 78.125000 ms to retrieve 94 items.
Oct 27, 2018 02:21:33.424 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122127&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:33.471 [10292] DEBUG - Analyzing media parts for item 122494 (The Croods): 111593,111594
Oct 27, 2018 02:21:33.471 [10292] DEBUG - [ID 115165] Media part analysis: \\network2\video\Childrens\The Croods 3D.mp4
Oct 27, 2018 02:21:33.471 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\The Croods 3D.mp4"
Oct 27, 2018 02:21:33.471 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\The Croods 3D.mp4' for reading
Oct 27, 2018 02:21:33.471 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:33.518 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:33.518 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:33.518 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:33.611 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:33.611 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:33.674 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1549568206 bytes read:3056642 seeks:1 nb_streams:2
Oct 27, 2018 02:21:33.674 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:33.674 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:33.674 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:33.674 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:33.690 [10292] VERBOSE - [FFMPEG] - Reinit context to 1920x1088, pix_fmt: yuv420p
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.690 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:33.705 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.705 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:33.705 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.705 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.705 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.705 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.721 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.721 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.721 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.721 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.721 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:33.721 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:33.736 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:33.752 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:33.752 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3044856 bytes read:3089410 seeks:2 frames:13
Oct 27, 2018 02:21:33.752 [10292] DEBUG - [MI] Opening "\\network2\video\Childrens\The Croods 3D.mp4" for MP4 atom parsing
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 3042631 at offset 24
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1728257 at offset 161
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1314237 at offset 1728418
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1728157 at offset 261
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1728023 at offset 395
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1727959 at offset 459
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1314137 at offset 1728518
Oct 27, 2018 02:21:33.752 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1314042 at offset 1728613
Oct 27, 2018 02:21:33.768 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1313982 at offset 1728673
Oct 27, 2018 02:21:33.768 [10292] DEBUG - [MI]  * 628950cf3ff9fb942740aa8d096fce5c352f2bc3 [mp4 h264/aac] Duration: 5919955ms, 1920x1080 (1.777778) 23.976fps, bitrate=2094kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Childrens\The Croods 3D.mp4")
Oct 27, 2018 02:21:33.768 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:33.768 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\The Croods 3D.mp4"
Oct 27, 2018 02:21:33.783 [10292] DEBUG - [FFMPEG] - Statistics: 3089410 bytes read, 2 seeks
Oct 27, 2018 02:21:33.783 [10292] DEBUG - Updating media item 111593, size=1549568233, metadata_item_id=122494
Oct 27, 2018 02:21:33.783 [10292] DEBUG - Updating part with ID=115165 [\\network2\video\Childrens\The Croods 3D.mp4]
Oct 27, 2018 02:21:33.862 [10292] DEBUG - [ID 115166] Media part analysis: \\network2\video\Childrens\The Croods.mp4
Oct 27, 2018 02:21:33.862 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:33.862 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\The Croods.mp4"
Oct 27, 2018 02:21:33.862 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\The Croods.mp4' for reading
Oct 27, 2018 02:21:33.862 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:33.862 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:33.877 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:33.877 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:33.877 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:33.893 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:33.893 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:33.893 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:33.909 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:34.018 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:34.018 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 793155817 bytes read:3037485 seeks:1 nb_streams:2
Oct 27, 2018 02:21:34.065 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:34.065 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:34.065 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:34.065 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:34.080 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3025042 bytes read:3070253 seeks:2 frames:13
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [MI] Opening "\\network2\video\Childrens\The Croods.mp4" for MP4 atom parsing
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 3023474 at offset 24
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1709100 at offset 161
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1314237 at offset 1709261
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1709000 at offset 261
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1708866 at offset 395
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1708802 at offset 459
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1314137 at offset 1709361
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1314042 at offset 1709456
Oct 27, 2018 02:21:34.096 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1313982 at offset 1709516
Oct 27, 2018 02:21:34.096 [10292] DEBUG - [MI]  * 9391458bda133563ea323def79de828902e9bec5 [mp4 h264/aac] Duration: 5916992ms, 1280x544 (2.352941) 23.976fps, bitrate=1072kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Childrens\The Croods.mp4")
Oct 27, 2018 02:21:34.112 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:34.112 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\The Croods.mp4"
Oct 27, 2018 02:21:34.112 [10292] DEBUG - [FFMPEG] - Statistics: 3070253 bytes read, 2 seeks
Oct 27, 2018 02:21:34.112 [10292] DEBUG - Updating media item 111594, size=793155844, metadata_item_id=122494
Oct 27, 2018 02:21:34.112 [10292] DEBUG - Updating part with ID=115166 [\\network2\video\Childrens\The Croods.mp4]
Oct 27, 2018 02:21:34.174 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:34.190 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:34.190 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:34.205 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:34.205 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:34.221 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122494&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:34.252 [10292] DEBUG - Analyzing media parts for item 122429 (How to Train Your Dragon): 111528
Oct 27, 2018 02:21:34.252 [10292] DEBUG - [ID 115099] Media part analysis: \\network2\video\Childrens\How to Train Your Dragon.avi
Oct 27, 2018 02:21:34.252 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\How to Train Your Dragon.avi"
Oct 27, 2018 02:21:34.252 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\How to Train Your Dragon.avi' for reading
Oct 27, 2018 02:21:34.252 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:34.268 [10292] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:21:34.268 [10292] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:21:34.549 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4668120 seeks:6 nb_streams:2
Oct 27, 2018 02:21:34.565 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:34.565 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 40671 bytes read:4668120 seeks:6 frames:16
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [MI]  * 7e24c1b2e149709eb4d6cfe1c2fc12f201fd144b [avi mpeg4/ac3] Duration: 5870948ms, 720x304 (2.368421) 23.976fps, bitrate=1994kbps, audio channels=6, optimizedForStreaming=0 ("\\network2\video\Childrens\How to Train Your Dragon.avi")
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\How to Train Your Dragon.avi"
Oct 27, 2018 02:21:34.565 [10292] DEBUG - [FFMPEG] - Statistics: 4668120 bytes read, 6 seeks
Oct 27, 2018 02:21:34.580 [10292] DEBUG - Updating media item 111528, size=1463523328, metadata_item_id=122429
Oct 27, 2018 02:21:34.580 [10292] DEBUG - Updating part with ID=115099 [\\network2\video\Childrens\How to Train Your Dragon.avi]
Oct 27, 2018 02:21:34.643 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122429&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:34.658 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122429&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:34.658 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122429&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:34.674 [10292] DEBUG - It took 15.625000 ms to retrieve 128 items.
Oct 27, 2018 02:21:34.674 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122429&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:34.674 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122429&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:34.690 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122429&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:34.721 [10292] DEBUG - Analyzing media parts for item 122205 (The Hobbit: The Desolation of Smaug): 111402,111400,111401
Oct 27, 2018 02:21:34.721 [10292] DEBUG - [ID 114973] Media part analysis: \\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4
Oct 27, 2018 02:21:34.768 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4"
Oct 27, 2018 02:21:34.768 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4' for reading
Oct 27, 2018 02:21:34.768 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:34.815 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:34.815 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:34.815 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:35.033 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:35.033 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 2208430513 bytes read:4993009 seeks:1 nb_streams:2
Oct 27, 2018 02:21:35.080 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:35.080 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:35.080 [10292] VERBOSE - [FFMPEG] - Reinit context to 1920x800, pix_fmt: yuv420p
Oct 27, 2018 02:21:35.080 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.096 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.112 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4980988 bytes read:5025777 seeks:2 frames:13
Oct 27, 2018 02:21:35.127 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4" for MP4 atom parsing
Oct 27, 2018 02:21:35.127 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:35.127 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 4979022 at offset 24
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2829448 at offset 161
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2149437 at offset 2829609
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2829348 at offset 261
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2829214 at offset 395
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2829150 at offset 459
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2149337 at offset 2829709
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2149242 at offset 2829804
Oct 27, 2018 02:21:35.143 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2149182 at offset 2829864
Oct 27, 2018 02:21:35.143 [10292] DEBUG - [MI]  * c59910007a8e72b68d69505b7ad7231520d50b17 [mp4 h264/aac] Duration: 9678037ms, 1920x800 (2.400000) 23.976fps, bitrate=1825kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4")
Oct 27, 2018 02:21:35.143 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:35.143 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4"
Oct 27, 2018 02:21:35.159 [10292] DEBUG - [FFMPEG] - Statistics: 5025777 bytes read, 2 seeks
Oct 27, 2018 02:21:35.159 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:35.159 [10292] DEBUG - Updating media item 111402, size=2208430540, metadata_item_id=122205
Oct 27, 2018 02:21:35.221 [10292] DEBUG - Updating part with ID=114973 [\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013).mp4]
Oct 27, 2018 02:21:35.252 [10292] DEBUG - [ID 114971] Media part analysis: \\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4
Oct 27, 2018 02:21:35.252 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:35.268 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:35.268 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:35.283 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:35.283 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:35.283 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:35.315 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4"
Oct 27, 2018 02:21:35.315 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4' for reading
Oct 27, 2018 02:21:35.315 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:35.346 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:35.346 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:35.346 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:35.533 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:35.533 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1041403518 bytes read:4995694 seeks:1 nb_streams:2
Oct 27, 2018 02:21:35.580 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:35.580 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:35.580 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:21:35.580 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.596 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4983277 bytes read:5028462 seeks:2 frames:13
Oct 27, 2018 02:21:35.612 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4" for MP4 atom parsing
Oct 27, 2018 02:21:35.612 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:35.612 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 4981707 at offset 24
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2832133 at offset 161
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2149437 at offset 2832294
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2832033 at offset 261
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2831899 at offset 395
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2831835 at offset 459
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2149337 at offset 2832394
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2149242 at offset 2832489
Oct 27, 2018 02:21:35.627 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2149182 at offset 2832549
Oct 27, 2018 02:21:35.627 [10292] DEBUG - [MI]  * 2270620f2e00279653c91ff73b09b7e45ca24913 [mp4 h264/aac] Duration: 9678037ms, 1280x534 (2.397004) 23.976fps, bitrate=860kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4")
Oct 27, 2018 02:21:35.627 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:35.627 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4"
Oct 27, 2018 02:21:35.643 [10292] DEBUG - [FFMPEG] - Statistics: 5028462 bytes read, 2 seeks
Oct 27, 2018 02:21:35.643 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:35.643 [10292] DEBUG - Updating media item 111400, size=1041403545, metadata_item_id=122205
Oct 27, 2018 02:21:35.643 [10292] DEBUG - Updating part with ID=114971 [\\network2\video\Movies\The Hobbit - The Desolation of Smaug (2013).mp4]
Oct 27, 2018 02:21:35.674 [10292] DEBUG - [ID 114972] Media part analysis: \\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4
Oct 27, 2018 02:21:35.674 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:35.674 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4"
Oct 27, 2018 02:21:35.674 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4' for reading
Oct 27, 2018 02:21:35.674 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:35.674 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:35.674 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:35.674 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:35.674 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:35.690 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:35.690 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:35.690 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:35.690 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:35.893 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:35.893 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:35.940 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1041403518 bytes read:4995694 seeks:1 nb_streams:2
Oct 27, 2018 02:21:35.940 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:35.940 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:35.940 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:35.940 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:35.956 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.956 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4983277 bytes read:5028462 seeks:2 frames:13
Oct 27, 2018 02:21:35.971 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4" for MP4 atom parsing
Oct 27, 2018 02:21:35.971 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:35.971 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 4981707 at offset 24
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2832133 at offset 161
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2149437 at offset 2832294
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2832033 at offset 261
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2831899 at offset 395
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2831835 at offset 459
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2149337 at offset 2832394
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2149242 at offset 2832489
Oct 27, 2018 02:21:35.987 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2149182 at offset 2832549
Oct 27, 2018 02:21:35.987 [10292] DEBUG - [MI]  * 2270620f2e00279653c91ff73b09b7e45ca24913 [mp4 h264/aac] Duration: 9678037ms, 1280x534 (2.397004) 23.976fps, bitrate=860kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4")
Oct 27, 2018 02:21:35.987 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:35.987 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4"
Oct 27, 2018 02:21:36.003 [10292] DEBUG - [FFMPEG] - Statistics: 5028462 bytes read, 2 seeks
Oct 27, 2018 02:21:36.003 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:36.003 [10292] DEBUG - Updating media item 111401, size=1041403545, metadata_item_id=122205
Oct 27, 2018 02:21:36.003 [10292] DEBUG - Updating part with ID=114972 [\\network2\video\Movies\The Hobbit The Desolation of Smaug (2013) - 720p.mp4]
Oct 27, 2018 02:21:36.081 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:36.096 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:36.096 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:36.112 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:36.112 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:36.112 [10292] DEBUG - It took 15.625000 ms to retrieve 132 items.
Oct 27, 2018 02:21:36.128 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122205&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:36.159 [10292] DEBUG - Analyzing media parts for item 121950 (Avengers: Age of Ultron): 111145
Oct 27, 2018 02:21:36.159 [10292] DEBUG - [ID 114714] Media part analysis: \\network2\video\Movies\Avengers - Age of Ultron (2015).mp4
Oct 27, 2018 02:21:36.206 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\Avengers - Age of Ultron (2015).mp4"
Oct 27, 2018 02:21:36.206 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\Avengers - Age of Ultron (2015).mp4' for reading
Oct 27, 2018 02:21:36.206 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:36.268 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:36.268 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:36.268 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:36.456 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:36.456 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 976130866 bytes read:4382377 seeks:1 nb_streams:2
Oct 27, 2018 02:21:36.518 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:36.518 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:36.518 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x544, pix_fmt: yuv420p
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:36.518 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:36.534 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:36.550 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4359448 bytes read:4415145 seeks:2 frames:13
Oct 27, 2018 02:21:36.550 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\Avengers - Age of Ultron (2015).mp4" for MP4 atom parsing
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 4357934 at offset 24
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 2474664 at offset 161
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1883133 at offset 2474825
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 2474564 at offset 261
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 2474430 at offset 395
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 2474366 at offset 459
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1883033 at offset 2474925
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1882938 at offset 2475020
Oct 27, 2018 02:21:36.550 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1882878 at offset 2475080
Oct 27, 2018 02:21:36.550 [10292] DEBUG - [MI]  * ce3e6d3a4e56326738030f9095f6c47fa5227ed8 [mp4 h264/aac] Duration: 8478827ms, 1280x536 (2.388060) 23.976fps, bitrate=921kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\Avengers - Age of Ultron (2015).mp4")
Oct 27, 2018 02:21:36.550 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:36.550 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\Avengers - Age of Ultron (2015).mp4"
Oct 27, 2018 02:21:36.565 [10292] DEBUG - [FFMPEG] - Statistics: 4415145 bytes read, 2 seeks
Oct 27, 2018 02:21:36.565 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:36.565 [10292] DEBUG - Updating media item 111145, size=976130893, metadata_item_id=121950
Oct 27, 2018 02:21:36.565 [10292] DEBUG - Updating part with ID=114714 [\\network2\video\Movies\Avengers - Age of Ultron (2015).mp4]
Oct 27, 2018 02:21:36.643 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121950&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:36.659 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121950&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:36.659 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121950&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:36.675 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121950&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:36.675 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121950&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:36.675 [10292] DEBUG - It took 0.000000 ms to retrieve 120 items.
Oct 27, 2018 02:21:36.675 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=121950&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:36.690 [10292] DEBUG - Analyzing media parts for item 122242 (The Shawshank Redemption): 111437
Oct 27, 2018 02:21:36.690 [10292] DEBUG - [ID 115008] Media part analysis: \\network2\video\Movies\The Shawshank Redemption (1994).avi
Oct 27, 2018 02:21:36.737 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Shawshank Redemption (1994).avi"
Oct 27, 2018 02:21:36.737 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Shawshank Redemption (1994).avi' for reading
Oct 27, 2018 02:21:36.737 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:36.784 [10292] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:21:36.784 [10292] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:21:36.784 [10292] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Oct 27, 2018 02:21:37.362 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:8882834 seeks:5 nb_streams:2
Oct 27, 2018 02:21:37.378 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:37.378 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 21652 bytes read:8882834 seeks:5 frames:22
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [MI]  * 8755eca11814c222044c245a514ed2072cdacabf [avi mpeg4/mp3] Duration: 8173968ms, 560x320 (1.750000) 25.000fps, bitrate=721kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Movies\The Shawshank Redemption (1994).avi")
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Shawshank Redemption (1994).avi"
Oct 27, 2018 02:21:37.378 [10292] DEBUG - [FFMPEG] - Statistics: 8882834 bytes read, 5 seeks
Oct 27, 2018 02:21:37.378 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:37.393 [10292] DEBUG - Updating media item 111437, size=737107968, metadata_item_id=122242
Oct 27, 2018 02:21:37.393 [10292] DEBUG - Updating part with ID=115008 [\\network2\video\Movies\The Shawshank Redemption (1994).avi]
Oct 27, 2018 02:21:37.456 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122242&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:37.471 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122242&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:37.471 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122242&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:37.487 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122242&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:37.487 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122242&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:37.487 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122242&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:37.518 [10292] DEBUG - Analyzing media parts for item 122520 (The Smurfs): 111619
Oct 27, 2018 02:21:37.518 [10292] DEBUG - [ID 115191] Media part analysis: \\network2\video\Childrens\The Smurfs.avi
Oct 27, 2018 02:21:37.518 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\The Smurfs.avi"
Oct 27, 2018 02:21:37.518 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\The Smurfs.avi' for reading
Oct 27, 2018 02:21:37.518 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:37.565 [10292] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 27, 2018 02:21:37.565 [10292] DEBUG - [FFMPEG] - use odml:1
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4892280 seeks:5 nb_streams:2
Oct 27, 2018 02:21:37.925 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:37.925 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 20756 bytes read:4892280 seeks:5 frames:21
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [MI]  * 9816bd326a92a10ecb8ec4bc803a0963296af1f5 [avi mpeg4/mp3] Duration: 6163157ms, 640x352 (1.818182) 23.976fps, bitrate=950kbps, audio channels=2, optimizedForStreaming=0 ("\\network2\video\Childrens\The Smurfs.avi")
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\The Smurfs.avi"
Oct 27, 2018 02:21:37.925 [10292] DEBUG - [FFMPEG] - Statistics: 4892280 bytes read, 5 seeks
Oct 27, 2018 02:21:37.941 [10292] DEBUG - Updating media item 111619, size=732457968, metadata_item_id=122520
Oct 27, 2018 02:21:37.941 [10292] DEBUG - Updating part with ID=115191 [\\network2\video\Childrens\The Smurfs.avi]
Oct 27, 2018 02:21:38.019 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122520&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:38.034 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122520&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:38.034 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122520&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:38.050 [10292] DEBUG - It took 0.000000 ms to retrieve 101 items.
Oct 27, 2018 02:21:38.050 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122520&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:38.050 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122520&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:38.050 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122520&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:38.066 [10292] DEBUG - Analyzing media parts for item 122221 (The Lord of the Rings: The Fellowship of the Ring): 111416
Oct 27, 2018 02:21:38.081 [10292] DEBUG - [ID 114987] Media part analysis: \\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4
Oct 27, 2018 02:21:38.128 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4"
Oct 27, 2018 02:21:38.128 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4' for reading
Oct 27, 2018 02:21:38.128 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:38.160 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:38.160 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:38.160 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:38.441 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:38.441 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1509349936 bytes read:7084139 seeks:1 nb_streams:2
Oct 27, 2018 02:21:38.503 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:38.503 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:38.503 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x528, pix_fmt: yuv420p
Oct 27, 2018 02:21:38.503 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:38.519 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Oct 27, 2018 02:21:38.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.534 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.534 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:38.534 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 7073672 bytes read:7116907 seeks:2 frames:13
Oct 27, 2018 02:21:38.534 [10292] DEBUG - [MI] Opening "\\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4" for MP4 atom parsing
Oct 27, 2018 02:21:38.534 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:38.534 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 7072376 at offset 24
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 4031470 at offset 161
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 3040769 at offset 4031631
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 4031370 at offset 261
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 4031297 at offset 334
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 4031233 at offset 398
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 3040669 at offset 4031731
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 3040574 at offset 4031826
Oct 27, 2018 02:21:38.550 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 3040514 at offset 4031886
Oct 27, 2018 02:21:38.550 [10292] DEBUG - [MI]  * 65f8bf9826f7309be5f8201b1f913d9d8bd165d3 [mp4 h264/aac] Duration: 13691753ms, 1280x528 (2.424242) 23.976fps, bitrate=881kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4")
Oct 27, 2018 02:21:38.550 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:38.550 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4"
Oct 27, 2018 02:21:38.566 [10292] DEBUG - [FFMPEG] - Statistics: 7116907 bytes read, 2 seeks
Oct 27, 2018 02:21:38.566 [10292] DEBUG - Streams didn't change in analysis, not saving.
Oct 27, 2018 02:21:38.566 [10292] DEBUG - Updating media item 111416, size=1509349967, metadata_item_id=122221
Oct 27, 2018 02:21:38.566 [10292] DEBUG - Updating part with ID=114987 [\\network2\video\Movies\The Lord of the Rings The Fellowship of the Ring (2001).mp4]
Oct 27, 2018 02:21:38.613 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122221&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:38.613 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122221&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:38.613 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122221&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:38.613 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122221&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:38.613 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122221&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:38.628 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=13&metadataItemID=122221&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:38.659 [10292] DEBUG - Analyzing media parts for item 122471 (Planes): 111570
Oct 27, 2018 02:21:38.659 [10292] DEBUG - [ID 115141] Media part analysis: \\network2\video\Childrens\Planes.mp4
Oct 27, 2018 02:21:38.659 [10292] DEBUG - [MI] Opening input file: "\\network2\video\Childrens\Planes.mp4"
Oct 27, 2018 02:21:38.659 [10292] DEBUG - [FFMPEG] - Opening '\\network2\video\Childrens\Planes.mp4' for reading
Oct 27, 2018 02:21:38.659 [10292] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 27, 2018 02:21:38.706 [10292] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 27, 2018 02:21:38.706 [10292] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 27, 2018 02:21:38.706 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:38.800 [10292] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 27, 2018 02:21:38.800 [10292] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 788169049 bytes read:2821353 seeks:1 nb_streams:2
Oct 27, 2018 02:21:38.863 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 27, 2018 02:21:38.863 [10292] VERBOSE - [FFMPEG] - Rescanning for external libs: 'C\:\\Users\\craig\\AppData\\Local\\Plex\ Media\ Server\\Codecs\\e7828f1-1324-windows-i386\\'
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 27, 2018 02:21:38.863 [10292] VERBOSE - [FFMPEG] - Reinit context to 1280x720, pix_fmt: yuv420p
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - no picture 
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:38.863 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.878 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [FFMPEG] - All info found
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2805357 bytes read:2854121 seeks:2 frames:13
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [MI] Opening "\\network2\video\Childrens\Planes.mp4" for MP4 atom parsing
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found moov atom of size 2803662 at offset 24
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1582928 at offset 161
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found trak atom of size 1220597 at offset 1583089
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1582828 at offset 261
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1582690 at offset 399
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1582626 at offset 463
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found mdia atom of size 1220497 at offset 1583189
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found minf atom of size 1220402 at offset 1583284
Oct 27, 2018 02:21:38.894 [10292] DEBUG - Mp4AtomParser: Found stbl atom of size 1220342 at offset 1583344
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [MI]  * 8b7c12108790e4a0f1d7e7dc048f3308dbe0632f [mp4 h264/aac] Duration: 5495360ms, 1280x720 (1.777778) 23.976fps, bitrate=1147kbps, audio channels=2, optimizedForStreaming=1 ("\\network2\video\Childrens\Planes.mp4")
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 27, 2018 02:21:38.894 [10292] DEBUG - [MI] Closing input file: "\\network2\video\Childrens\Planes.mp4"
Oct 27, 2018 02:21:38.910 [10292] DEBUG - [FFMPEG] - Statistics: 2854121 bytes read, 2 seeks
Oct 27, 2018 02:21:38.910 [10292] DEBUG - Updating media item 111570, size=788169080, metadata_item_id=122471
Oct 27, 2018 02:21:38.910 [10292] DEBUG - Updating part with ID=115141 [\\network2\video\Childrens\Planes.mp4]
Oct 27, 2018 02:21:38.972 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122471&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:38.988 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122471&metadataType=1&state=-1&mediaState=analyzing
Oct 27, 2018 02:21:38.988 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122471&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:38.988 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122471&metadataType=1&state=-1&mediaState=thumbnailing
Oct 27, 2018 02:21:38.988 [9124] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122471&metadataType=1&state=-1&mediaState=idle
Oct 27, 2018 02:21:38.988 [9124] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=14&metadataItemID=122471&metadataType=1&state=-1&mediaState=idle
