Sep 06, 2018 02:11:50.702 [3088] INFO - Plex Media Scanner v1.13.5.5332-21ab172de - Microsoft PC x64 - build: windows-i386 - GMT -04:00
Sep 06, 2018 02:11:50.702 [3088] INFO - Windows version: 6.2 (Build 9200), language en-US
Sep 06, 2018 02:11:50.702 [3088] INFO - 8 2195 MHz processor(s): Architecture=0, Level=6, Revision=15363 Processor Identifier=Intel64 Family 6 Model 60 Stepping 3, GenuineIntel
Sep 06, 2018 02:11:50.703 [3088] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 5306,776 --log-file-suffix " Analysis" 
Sep 06, 2018 02:11:50.704 [8536] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Sep 06, 2018 02:11:50.810 [8536] DEBUG - Analyzing media parts for item 5306 (Murder on the Orient Express): 13407
Sep 06, 2018 02:11:50.812 [8536] DEBUG - [ID 13419] Media part analysis: E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4
Sep 06, 2018 02:11:50.821 [8536] DEBUG - [MI] Opening input file: "E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4"
Sep 06, 2018 02:11:50.821 [8536] DEBUG - [FFMPEG] - Opening 'E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4' for reading
Sep 06, 2018 02:11:50.821 [8536] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 06, 2018 02:11:50.821 [8536] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 06, 2018 02:11:50.822 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.822 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.822 [8536] ERROR - [FFMPEG] - moov atom not found
Sep 06, 2018 02:11:50.822 [8536] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 3 seeks
Sep 06, 2018 02:11:50.840 [8536] ERROR - Exception analyzing media file 'E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4' (Could not parse E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4 (error=-1094995529): Invalid data found when processing input)
Sep 06, 2018 02:11:50.840 [8536] DEBUG - Streams didn't change in analysis, not saving.
Sep 06, 2018 02:11:50.840 [8536] DEBUG - Updating media item 13407, size=131072, metadata_item_id=5306
Sep 06, 2018 02:11:50.841 [8536] DEBUG - Updating part with ID=13419 [E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4]
Sep 06, 2018 02:11:50.886 [8536] DEBUG - [MI] Opening input file: "E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4"
Sep 06, 2018 02:11:50.886 [8536] DEBUG - [FFMPEG] - Opening 'E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4' for reading
Sep 06, 2018 02:11:50.886 [8536] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 06, 2018 02:11:50.887 [8536] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 06, 2018 02:11:50.887 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.887 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.887 [8536] ERROR - [FFMPEG] - moov atom not found
Sep 06, 2018 02:11:50.887 [8536] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 3 seeks
Sep 06, 2018 02:11:50.887 [8536] ERROR - Exception extracting thumbnail from media file 'E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4' (Could not parse E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4 (error=-1094995529): Invalid data found when processing input)
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [MI] Opening input file: "E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4"
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [FFMPEG] - Opening 'E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4' for reading
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.888 [8536] ERROR - [FFMPEG] - moov atom not found
Sep 06, 2018 02:11:50.888 [8536] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 3 seeks
Sep 06, 2018 02:11:50.888 [8536] ERROR - Exception extracting thumbnail from media file 'E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4' (Could not parse E:\Movies\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG\Murder.On.The.Orient.Express.2017.1080p.BluRay.H264.AAC-RARBG.mp4 (error=-1094995529): Invalid data found when processing input)
Sep 06, 2018 02:11:50.889 [8536] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:50.890 [8536] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:50.892 [8536] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:50.893 [8536] DEBUG - Updating metadata item (save) (Murder on the Orient Express) with ID 5306
Sep 06, 2018 02:11:50.911 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5306&metadataType=1&state=-1&mediaState=analyzing
Sep 06, 2018 02:11:50.917 [8536] DEBUG - Analyzing media parts for item 776 (Split): 1013,1014
Sep 06, 2018 02:11:50.919 [8536] DEBUG - [ID 1013] Media part analysis: E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4
Sep 06, 2018 02:11:50.919 [8536] DEBUG - [MI] Opening input file: "E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4"
Sep 06, 2018 02:11:50.919 [8536] DEBUG - [FFMPEG] - Opening 'E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4' for reading
Sep 06, 2018 02:11:50.919 [8536] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 06, 2018 02:11:50.920 [8536] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 06, 2018 02:11:50.920 [8536] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Sep 06, 2018 02:11:50.920 [8536] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 06, 2018 02:11:50.922 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5306&metadataType=1&state=-1&mediaState=analyzing
Sep 06, 2018 02:11:50.922 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5306&metadataType=1&state=-1&mediaState=thumbnailing
Sep 06, 2018 02:11:50.924 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5306&metadataType=1&state=-1&mediaState=thumbnailing
Sep 06, 2018 02:11:50.924 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5306&metadataType=1&state=-1&mediaState=idle
Sep 06, 2018 02:11:50.935 [8536] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 2002, duration: 168668480
Sep 06, 2018 02:11:50.936 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=5306&metadataType=1&state=-1&mediaState=idle
Sep 06, 2018 02:11:50.948 [8536] DEBUG - [FFMPEG] - Offset DTS by 2002 to make first pts zero.
Sep 06, 2018 02:11:50.973 [8536] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 06, 2018 02:11:50.974 [8536] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 06, 2018 02:11:50.988 [8536] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1841899216 bytes read:3645928 seeks:1 nb_streams:2
Sep 06, 2018 02:11:50.988 [8536] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 06, 2018 02:11:50.988 [8536] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 06, 2018 02:11:50.991 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:50.991 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 06, 2018 02:11:50.991 [8536] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 06, 2018 02:11:50.993 [8536] DEBUG - [FFMPEG] - no picture 
Sep 06, 2018 02:11:50.995 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 06, 2018 02:11:50.996 [8536] DEBUG - [FFMPEG] - no picture 
Sep 06, 2018 02:11:50.997 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 06, 2018 02:11:51.000 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.004 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.007 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 06, 2018 02:11:51.008 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 06, 2018 02:11:51.010 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.013 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.016 [8536] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Sep 06, 2018 02:11:51.016 [8536] DEBUG - [FFMPEG] - All info found
Sep 06, 2018 02:11:51.016 [8536] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3644789 bytes read:3678696 seeks:2 frames:13
Sep 06, 2018 02:11:51.016 [8536] DEBUG - [MI] Opening "E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4" for MP4 atom parsing
Sep 06, 2018 02:11:51.017 [8536] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 20 at offset 0
Sep 06, 2018 02:11:51.017 [8536] DEBUG - Mp4AtomParser: Found moov atom of size 3641578 at offset 20
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found trak atom of size 2080729 at offset 157
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found trak atom of size 1560712 at offset 2080886
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found mdia atom of size 2080593 at offset 293
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found minf atom of size 2080520 at offset 366
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found stbl atom of size 2080456 at offset 430
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found mdia atom of size 1560612 at offset 2080986
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found minf atom of size 1560539 at offset 2081059
Sep 06, 2018 02:11:51.019 [8536] DEBUG - Mp4AtomParser: Found stbl atom of size 1560479 at offset 2081119
Sep 06, 2018 02:11:51.020 [8536] DEBUG - [MI]  * 21ea6de524bc3a3c145c95f9a1d4abddc0f3f093 [mp4 h264/aac] Duration: 7027853ms, 1920x808 (2.376238) 23.976fps, bitrate=2096kbps, audio channels=2, optimizedForStreaming=1 ("E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4")
Sep 06, 2018 02:11:51.020 [8536] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 06, 2018 02:11:51.020 [8536] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.021 [8536] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.032 [8536] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.032 [8536] DEBUG - Updating metadata item (save) (Split) with ID 776
Sep 06, 2018 02:11:51.053 [8536] DEBUG - Doing expensive tags write for 'Split' because something changed.
Sep 06, 2018 02:11:51.069 [8536] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.069 [8536] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.080 [8536] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.080 [8536] DEBUG - Updating metadata item (save) (Split) with ID 776
Sep 06, 2018 02:11:51.108 [8536] DEBUG - [MI] Closing input file: "E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4"
Sep 06, 2018 02:11:51.112 [8536] DEBUG - [FFMPEG] - Statistics: 3678696 bytes read, 2 seeks
Sep 06, 2018 02:11:51.113 [8536] DEBUG - Updating media item 1013, size=1841899266, metadata_item_id=776
Sep 06, 2018 02:11:51.113 [8536] DEBUG - Updating part with ID=1013 [E:\Movies\Split.2016.1080p.BRRip.x264.AAC-ETRG\Split.2016.1080p.BRRip.x264.AAC-ETRG.mp4]
Sep 06, 2018 02:11:51.137 [8536] DEBUG - [ID 1014] Media part analysis: E:\Movies\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD]\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv
Sep 06, 2018 02:11:51.137 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=analyzing
Sep 06, 2018 02:11:51.137 [8536] DEBUG - [MI] Opening input file: "E:\Movies\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD]\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv"
Sep 06, 2018 02:11:51.137 [8536] DEBUG - [FFMPEG] - Opening 'E:\Movies\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD]\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv' for reading
Sep 06, 2018 02:11:51.137 [8536] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 06, 2018 02:11:51.139 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=analyzing
Sep 06, 2018 02:11:51.139 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=thumbnailing
Sep 06, 2018 02:11:51.150 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=thumbnailing
Sep 06, 2018 02:11:51.150 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=idle
Sep 06, 2018 02:11:51.162 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=idle
Sep 06, 2018 02:11:51.182 [8536] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 06, 2018 02:11:51.183 [8536] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 06, 2018 02:11:51.183 [8536] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 06, 2018 02:11:51.183 [8536] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 06, 2018 02:11:51.183 [8536] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 68473 bytes read:98304 seeks:0 nb_streams:7
Sep 06, 2018 02:11:51.184 [8536] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 1
Sep 06, 2018 02:11:51.184 [8536] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 1
Sep 06, 2018 02:11:51.186 [8536] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=24550
Sep 06, 2018 02:11:51.186 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.186 [8536] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=24548
Sep 06, 2018 02:11:51.186 [8536] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=24522
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker=ed avail_size_in_buf=24503
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker parser used 43 bytes (344 bits)
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=24457
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=24441
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - index=0
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - qscale[0]: 0
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - index=1
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - qscale[1]: 0
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=24307
Sep 06, 2018 02:11:51.187 [8536] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - sof0: picture: 1067x600
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - pix fmt id 11111100
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=24288
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - escaping removed 91 bytes
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=24087
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - marker parser used 23996 bytes (191968 bits)
Sep 06, 2018 02:11:51.188 [8536] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=5035
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=5033
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=5007
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=4988
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=4972
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - index=0
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - qscale[0]: 0
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - index=1
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - qscale[1]: 0
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Sep 06, 2018 02:11:51.189 [8536] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=4838
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - sof0: picture: 120x176
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - pix fmt id 11111100
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=4819
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - escaping removed 17 bytes
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=4679
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker parser used 4662 bytes (37296 bits)
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=8560
Sep 06, 2018 02:11:51.190 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=8558
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=8532
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker=ed avail_size_in_buf=8513
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker parser used 43 bytes (344 bits)
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=8467
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=8451
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - index=0
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - qscale[0]: 0
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - index=1
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - qscale[1]: 0
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=8317
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - sof0: picture: 213x120
Sep 06, 2018 02:11:51.191 [8536] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - pix fmt id 11111100
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=8298
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - escaping removed 28 bytes
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=8136
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker parser used 8108 bytes (64864 bits)
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=23752
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=23750
Sep 06, 2018 02:11:51.192 [8536] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=23724
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=23705
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=23689
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - index=0
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - qscale[0]: 0
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - index=1
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - qscale[1]: 0
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=23555
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - sof0: picture: 600x882
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - pix fmt id 11111100
Sep 06, 2018 02:11:51.193 [8536] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=23536
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - escaping removed 102 bytes
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=23337
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - marker parser used 23235 bytes (185880 bits)
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 1
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 1
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.194 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Sep 06, 2018 02:11:51.195 [8536] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 06, 2018 02:11:51.198 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.198 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.198 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.199 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.199 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.199 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.199 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.199 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.199 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.200 [8536] DEBUG - [FFMPEG] - no picture 
Sep 06, 2018 02:11:51.201 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.201 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.201 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.201 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.201 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.201 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.202 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.202 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.202 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.205 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.206 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.206 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.213 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.217 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.222 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.227 [8536] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Sep 06, 2018 02:11:51.232 [8536] DEBUG - [FFMPEG] - All info found
Sep 06, 2018 02:11:51.232 [8536] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 150641 bytes read:163840 seeks:0 frames:29
Sep 06, 2018 02:11:51.232 [8536] DEBUG - [MI]  * f4334d8956093d306687aef88c938803bf06d22b [mkv h264/ac3] Duration: 5548919ms, 1904x800 (2.380000) 23.976fps, bitrate=4876kbps, audio channels=6, optimizedForStreaming=0 ("E:\Movies\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD]\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv")
Sep 06, 2018 02:11:51.233 [8536] DEBUG - [MI] Importing 10 media chapters.
Sep 06, 2018 02:11:51.233 [8536] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 06, 2018 02:11:51.233 [8536] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.233 [8536] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.244 [8536] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.244 [8536] DEBUG - Updating metadata item (save) (Split) with ID 776
Sep 06, 2018 02:11:51.269 [8536] DEBUG - Doing expensive tags write for 'Split' because something changed.
Sep 06, 2018 02:11:51.294 [8536] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.294 [8536] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.305 [8536] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 06, 2018 02:11:51.305 [8536] DEBUG - Updating metadata item (save) (Split) with ID 776
Sep 06, 2018 02:11:51.336 [8536] DEBUG - [MI] Closing input file: "E:\Movies\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD]\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv"
Sep 06, 2018 02:11:51.339 [8536] DEBUG - [FFMPEG] - Statistics: 163840 bytes read, 0 seeks
Sep 06, 2018 02:11:51.340 [8536] DEBUG - Committing media stream changes for part 1014
Sep 06, 2018 02:11:51.378 [8536] DEBUG - Updating media item 1014, size=3382408840, metadata_item_id=776
Sep 06, 2018 02:11:51.378 [8536] DEBUG - Updating part with ID=1014 [E:\Movies\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD]\Split.2016.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv]
Sep 06, 2018 02:11:51.404 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=analyzing
Sep 06, 2018 02:11:51.415 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=analyzing
Sep 06, 2018 02:11:51.415 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=thumbnailing
Sep 06, 2018 02:11:51.417 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=thumbnailing
Sep 06, 2018 02:11:51.417 [2876] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=idle
Sep 06, 2018 02:11:51.428 [2876] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=776&metadataType=1&state=-1&mediaState=idle
