Aug 11, 2018 02:20:31.145 [9704] INFO - Plex Media Scanner v1.13.5.5291-6fa5e50a8 - Microsoft PC x64 - build: windows-i386 - GMT -07:00
Aug 11, 2018 02:20:31.145 [9704] INFO - Windows version: 6.2 (Build 9200), language en-US
Aug 11, 2018 02:20:31.146 [9704] INFO - 8 4013 MHz processor(s): Architecture=0, Level=21, Revision=512 Processor Identifier=AMD64 Family 21 Model 2 Stepping 0, AuthenticAMD
Aug 11, 2018 02:20:31.146 [9704] DEBUG - "C:\Program Files (x86)\Plex\Plex Media Server\Plex Media Scanner.exe" --analyze --item 201,20,205,11771,1,306,11774,56,11764,316 --log-file-suffix " Analysis" 
Aug 11, 2018 02:20:31.146 [13244] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Aug 11, 2018 02:20:31.300 [13244] DEBUG - It took 0.000000 ms to retrieve 121 items.
Aug 11, 2018 02:20:31.321 [13244] DEBUG - Analyzing media parts for item 201 (Mission: Impossible - Rogue Nation): 201
Aug 11, 2018 02:20:31.323 [13244] DEBUG - [ID 201] Media part analysis: F:\Videos\Movies\Mission Impossible Rogue Nation\Mission Impossible Rogue Nation.mkv
Aug 11, 2018 02:20:31.324 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\Mission Impossible Rogue Nation\Mission Impossible Rogue Nation.mkv"
Aug 11, 2018 02:20:31.324 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\Mission Impossible Rogue Nation\Mission Impossible Rogue Nation.mkv' for reading
Aug 11, 2018 02:20:31.325 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:31.343 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:31.346 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:31.346 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:31.346 [13244] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:31.346 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6684 bytes read:34077 seeks:2 nb_streams:3
Aug 11, 2018 02:20:31.347 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:31.348 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:31.350 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:31.350 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:31.351 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:31.351 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.351 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.351 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.351 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.351 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:31.354 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:31.356 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.356 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.357 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.357 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.359 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:31.361 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.361 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.361 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.361 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.367 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.367 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.367 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.368 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.375 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.375 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.375 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.375 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.382 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.382 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.382 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.383 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.389 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.389 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.389 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.390 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.397 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.397 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.397 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.397 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.400 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.400 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.400 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.400 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.403 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:31.404 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 57293 bytes read:99613 seeks:2 frames:58
Aug 11, 2018 02:20:31.405 [13244] DEBUG - [MI]  * 432ea03570f0e89e7f0ae94ba14618d173ce602e [mkv h264/dca] Duration: 7893761ms, 1920x804 (2.388060) 23.976fps, bitrate=3605kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Movies\Mission Impossible Rogue Nation\Mission Impossible Rogue Nation.mkv")
Aug 11, 2018 02:20:31.405 [13244] DEBUG - [MI] Importing 16 media chapters.
Aug 11, 2018 02:20:31.406 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:31.407 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\Mission Impossible Rogue Nation\Mission Impossible Rogue Nation.mkv"
Aug 11, 2018 02:20:31.411 [13244] DEBUG - [FFMPEG] - Statistics: 99613 bytes read, 2 seeks
Aug 11, 2018 02:20:31.412 [13244] DEBUG - Committing media stream changes for part 201
Aug 11, 2018 02:20:31.416 [13244] DEBUG - Updating media item 201, size=3557355167, metadata_item_id=201
Aug 11, 2018 02:20:31.417 [13244] DEBUG - Updating part with ID=201 [F:\Videos\Movies\Mission Impossible Rogue Nation\Mission Impossible Rogue Nation.mkv]
Aug 11, 2018 02:20:31.423 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=201&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:31.438 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=201&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:31.438 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=201&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:31.449 [13244] DEBUG - Analyzing media parts for item 20 (The Angry Birds Movie): 20
Aug 11, 2018 02:20:31.451 [13244] DEBUG - [ID 20] Media part analysis: F:\Videos\Movies\Angry Birds\Angry Birds.mkv
Aug 11, 2018 02:20:31.453 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\Angry Birds\Angry Birds.mkv"
Aug 11, 2018 02:20:31.453 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\Angry Birds\Angry Birds.mkv' for reading
Aug 11, 2018 02:20:31.453 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:31.458 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=201&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:31.458 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=201&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:31.463 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:31.471 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=201&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:31.472 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:31.473 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:31.473 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6605 bytes read:33585 seeks:2 nb_streams:2
Aug 11, 2018 02:20:31.474 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:31.475 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:31.476 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:31.477 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:31.477 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:31.477 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.477 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.478 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.478 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:31.478 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:31.484 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:31.488 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.489 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.489 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.489 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.491 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:31.494 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.494 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.494 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.494 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.503 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.503 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.503 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.503 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.514 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.514 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.514 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.514 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.524 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.524 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.524 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.524 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.531 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.531 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.531 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.531 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:31.539 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.539 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.540 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.540 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.543 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.543 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.543 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.543 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:31.550 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:31.550 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 49678 bytes read:99121 seeks:2 frames:50
Aug 11, 2018 02:20:31.551 [13244] DEBUG - [MI]  * 3a2ede3fa9f2afcac792ab29e8b5e6ae5815f1bc [mkv h264/dca] Duration: 5833835ms, 1920x1040 (1.846154) 23.976fps, bitrate=3606kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Movies\Angry Birds\Angry Birds.mkv")
Aug 11, 2018 02:20:31.552 [13244] DEBUG - [MI] Importing 16 media chapters.
Aug 11, 2018 02:20:31.552 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:31.554 [13244] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Aug 11, 2018 02:20:31.554 [13244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Aug 11, 2018 02:20:31.566 [13244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Aug 11, 2018 02:20:31.566 [13244] DEBUG - Updating metadata item (save) (The Angry Birds Movie) with ID 20
Aug 11, 2018 02:20:31.576 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\Angry Birds\Angry Birds.mkv"
Aug 11, 2018 02:20:31.580 [13244] DEBUG - [FFMPEG] - Statistics: 99121 bytes read, 2 seeks
Aug 11, 2018 02:20:31.581 [13244] DEBUG - Updating media item 20, size=2629860497, metadata_item_id=20
Aug 11, 2018 02:20:31.581 [13244] DEBUG - Updating part with ID=20 [F:\Videos\Movies\Angry Birds\Angry Birds.mkv]
Aug 11, 2018 02:20:31.588 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=20&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:31.599 [13244] DEBUG - Analyzing media parts for item 205 (The Meaning of Life): 205
Aug 11, 2018 02:20:31.600 [13244] DEBUG - [ID 205] Media part analysis: F:\Videos\Movies\Monty Python The Meaning of Life\Monty Python's The Meaning of Life.avi
Aug 11, 2018 02:20:31.601 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=20&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:31.601 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=20&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:31.602 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\Monty Python The Meaning of Life\Monty Python's The Meaning of Life.avi"
Aug 11, 2018 02:20:31.602 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\Monty Python The Meaning of Life\Monty Python's The Meaning of Life.avi' for reading
Aug 11, 2018 02:20:31.602 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:31.614 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=20&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:31.614 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=20&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:31.619 [13244] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Aug 11, 2018 02:20:31.619 [13244] DEBUG - [FFMPEG] - use odml:1
Aug 11, 2018 02:20:31.620 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Aug 11, 2018 02:20:31.628 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=20&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:31.968 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6921090 seeks:5 nb_streams:2
Aug 11, 2018 02:20:31.995 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:31.996 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:31.996 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 20872 bytes read:6921090 seeks:5 frames:22
Aug 11, 2018 02:20:31.996 [13244] DEBUG - [MI]  * bbd56ed560380fa9f4ab5d0fb7b1c4123cd98fe5 [avi mpeg4/mp3] Duration: 6433308ms, 640x336 (1.904762) 23.976fps, bitrate=1140kbps, audio channels=2, optimizedForStreaming=0 ("F:\Videos\Movies\Monty Python The Meaning of Life\Monty Python's The Meaning of Life.avi")
Aug 11, 2018 02:20:31.997 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:31.997 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\Monty Python The Meaning of Life\Monty Python's The Meaning of Life.avi"
Aug 11, 2018 02:20:32.000 [13244] DEBUG - [FFMPEG] - Statistics: 6921090 bytes read, 5 seeks
Aug 11, 2018 02:20:32.001 [13244] DEBUG - Updating media item 205, size=917293056, metadata_item_id=205
Aug 11, 2018 02:20:32.001 [13244] DEBUG - Updating part with ID=205 [F:\Videos\Movies\Monty Python The Meaning of Life\Monty Python's The Meaning of Life.avi]
Aug 11, 2018 02:20:32.007 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=205&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.010 [13244] DEBUG - Analyzing media parts for item 11771 (Black Dog Serenade): 17238
Aug 11, 2018 02:20:32.012 [13244] DEBUG - [ID 17316] Media part analysis: F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 16 - Black Dog Serenade (1080p x265 10bit Joy).mkv
Aug 11, 2018 02:20:32.013 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 16 - Black Dog Serenade (1080p x265 10bit Joy).mkv"
Aug 11, 2018 02:20:32.013 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 16 - Black Dog Serenade (1080p x265 10bit Joy).mkv' for reading
Aug 11, 2018 02:20:32.013 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.019 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=205&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.020 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=205&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.028 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:32.033 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=205&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.033 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=205&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.035 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.035 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.035 [13244] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.036 [13244] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.036 [13244] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.036 [13244] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.037 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 197392 bytes read:232297 seeks:2 nb_streams:8
Aug 11, 2018 02:20:32.038 [13244] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.038 [13244] DEBUG - [FFMPEG] - Decoding VPS
Aug 11, 2018 02:20:32.038 [13244] DEBUG - [FFMPEG] - Main 10 profile bitstream
Aug 11, 2018 02:20:32.038 [13244] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.038 [13244] DEBUG - [FFMPEG] - Decoding SPS
Aug 11, 2018 02:20:32.038 [13244] DEBUG - [FFMPEG] - Main 10 profile bitstream
Aug 11, 2018 02:20:32.039 [13244] DEBUG - [FFMPEG] - Decoding VUI
Aug 11, 2018 02:20:32.039 [13244] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.039 [13244] DEBUG - [FFMPEG] - Decoding PPS
Aug 11, 2018 02:20:32.039 [13244] DEBUG - [FFMPEG] - nal_unit_type: 39(SEI_PREFIX), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.039 [13244] DEBUG - [FFMPEG] - Decoding SEI
Aug 11, 2018 02:20:32.039 [13244] DEBUG - [FFMPEG] - Skipped PREFIX SEI 5
Aug 11, 2018 02:20:32.049 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=205&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.050 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:32.051 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 226354 bytes read:265065 seeks:2 frames:20
Aug 11, 2018 02:20:32.052 [13244] DEBUG - [MI]  * 43b823e94bd2fa8e7020901402f8f8284a34f9c6 [mkv hevc/aac] Duration: 1481418ms, 1440x1080 (1.333333) 23.976fps, bitrate=1204kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 16 - Black Dog Serenade (1080p x265 10bit Joy).mkv")
Aug 11, 2018 02:20:32.052 [13244] DEBUG - [MI] Importing 5 media chapters.
Aug 11, 2018 02:20:32.053 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 16 - Black Dog Serenade (1080p x265 10bit Joy).mkv"
Aug 11, 2018 02:20:32.055 [13244] DEBUG - [FFMPEG] - Statistics: 265065 bytes read, 2 seeks
Aug 11, 2018 02:20:32.057 [13244] DEBUG - Updating media item 17238, size=223011346, metadata_item_id=11771
Aug 11, 2018 02:20:32.057 [13244] DEBUG - Updating part with ID=17316 [F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 16 - Black Dog Serenade (1080p x265 10bit Joy).mkv]
Aug 11, 2018 02:20:32.068 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11771&metadataType=4&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.082 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11771&metadataType=4&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.082 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11771&metadataType=4&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.100 [13244] DEBUG - Analyzing media parts for item 1 (10 Cloverfield Lane): 1
Aug 11, 2018 02:20:32.102 [13244] DEBUG - [ID 1] Media part analysis: F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4
Aug 11, 2018 02:20:32.105 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4"
Aug 11, 2018 02:20:32.105 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11771&metadataType=4&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.105 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4' for reading
Aug 11, 2018 02:20:32.105 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.106 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11771&metadataType=4&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.119 [13244] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Aug 11, 2018 02:20:32.120 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11771&metadataType=4&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.120 [13244] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Aug 11, 2018 02:20:32.120 [13244] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Aug 11, 2018 02:20:32.146 [13244] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 1000, duration: 74503010
Aug 11, 2018 02:20:32.164 [13244] DEBUG - [FFMPEG] - Offset DTS by 1000 to make first pts zero.
Aug 11, 2018 02:20:32.180 [13244] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Aug 11, 2018 02:20:32.180 [13244] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Aug 11, 2018 02:20:32.210 [13244] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 1024, duration: 298310016
Aug 11, 2018 02:20:32.211 [13244] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Aug 11, 2018 02:20:32.241 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5552352 bytes read:5572598 seeks:0 nb_streams:2
Aug 11, 2018 02:20:32.242 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.242 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.245 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:32.245 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:32.246 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:32.249 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.251 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.253 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.256 [13244] DEBUG - [FFMPEG] - demuxer injecting skip 1024 / discard 0
Aug 11, 2018 02:20:32.257 [13244] DEBUG - [FFMPEG] - skip 1024 / discard 0 samples due to side data
Aug 11, 2018 02:20:32.257 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:32.257 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 5555180 bytes read:5572598 seeks:0 frames:3
Aug 11, 2018 02:20:32.257 [13244] DEBUG - [MI] Opening "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4" for MP4 atom parsing
Aug 11, 2018 02:20:32.257 [13244] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Aug 11, 2018 02:20:32.258 [13244] DEBUG - Mp4AtomParser: Found moov atom of size 5552304 at offset 32
Aug 11, 2018 02:20:32.264 [13244] DEBUG - Mp4AtomParser: Found trak atom of size 2728471 at offset 148
Aug 11, 2018 02:20:32.264 [13244] DEBUG - Mp4AtomParser: Found trak atom of size 2823619 at offset 2728619
Aug 11, 2018 02:20:32.264 [13244] DEBUG - Mp4AtomParser: Found mdia atom of size 2728335 at offset 284
Aug 11, 2018 02:20:32.264 [13244] DEBUG - Mp4AtomParser: Found minf atom of size 2728250 at offset 369
Aug 11, 2018 02:20:32.264 [13244] DEBUG - Mp4AtomParser: Found stbl atom of size 2728186 at offset 433
Aug 11, 2018 02:20:32.264 [13244] DEBUG - Mp4AtomParser: Found co64 atom of size 1192056 at offset 1536563
Aug 11, 2018 02:20:32.265 [13244] DEBUG - [MI] File has co64 atom with size 1192056 at offset 1536563
Aug 11, 2018 02:20:32.266 [13244] DEBUG - [MI]  * 596cfa1473aa9acc0fdcff7a1feb0098841075b1 [mp4 h264/aac] Duration: 6214814ms, 1920x800 (2.400000) 23.976fps, bitrate=6958kbps, audio channels=6, optimizedForStreaming=1 ("F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4")
Aug 11, 2018 02:20:32.267 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:32.267 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4"
Aug 11, 2018 02:20:32.271 [13244] DEBUG - [FFMPEG] - Statistics: 5572598 bytes read, 0 seeks
Aug 11, 2018 02:20:32.273 [13244] DEBUG - Updating media item 1, size=5405557033, metadata_item_id=1
Aug 11, 2018 02:20:32.273 [13244] DEBUG - Updating part with ID=1 [F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4]
Aug 11, 2018 02:20:32.278 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4"
Aug 11, 2018 02:20:32.278 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4' for reading
Aug 11, 2018 02:20:32.278 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.279 [13244] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Aug 11, 2018 02:20:32.279 [13244] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Aug 11, 2018 02:20:32.279 [13244] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Aug 11, 2018 02:20:32.297 [13244] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 1000, duration: 74503010
Aug 11, 2018 02:20:32.318 [13244] DEBUG - [FFMPEG] - Offset DTS by 1000 to make first pts zero.
Aug 11, 2018 02:20:32.334 [13244] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Aug 11, 2018 02:20:32.335 [13244] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Aug 11, 2018 02:20:32.356 [13244] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 1024, duration: 298310016
Aug 11, 2018 02:20:32.356 [13244] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Aug 11, 2018 02:20:32.382 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5552352 bytes read:5572598 seeks:0 nb_streams:2
Aug 11, 2018 02:20:32.383 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.383 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.387 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:32.388 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:32.388 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:32.392 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.394 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.397 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.400 [13244] DEBUG - [FFMPEG] - demuxer injecting skip 1024 / discard 0
Aug 11, 2018 02:20:32.400 [13244] DEBUG - [FFMPEG] - skip 1024 / discard 0 samples due to side data
Aug 11, 2018 02:20:32.400 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:32.401 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 5555180 bytes read:5572598 seeks:0 frames:3
Aug 11, 2018 02:20:32.401 [13244] DEBUG - Creating C:\Users\Lunar\AppData\Local\Plex Media Server\Media\localhost\5\96cfa1473aa9acc0fdcff7a1feb0098841075b1.bundle\Contents\Thumbnails\thumb1.jpg (50.0%, 720x512).
Aug 11, 2018 02:20:32.402 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.402 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.411 [13244] ERROR - [FFMPEG] - Invalid NAL unit size (0 > 82183).
Aug 11, 2018 02:20:32.411 [13244] ERROR - [FFMPEG] - Error splitting the input into NAL units.
Aug 11, 2018 02:20:32.411 [13244] ERROR - [MI] Error sending packet: Invalid data found when processing input
Aug 11, 2018 02:20:32.412 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.413 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.422 [13244] ERROR - [FFMPEG] - Invalid NAL unit size (0 > 124711).
Aug 11, 2018 02:20:32.422 [13244] ERROR - [FFMPEG] - Error splitting the input into NAL units.
Aug 11, 2018 02:20:32.423 [13244] ERROR - [MI] Error sending packet: Invalid data found when processing input
Aug 11, 2018 02:20:32.424 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.424 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.430 [13244] ERROR - [FFMPEG] - Invalid NAL unit size (0 > 243415).
Aug 11, 2018 02:20:32.430 [13244] ERROR - [FFMPEG] - Error splitting the input into NAL units.
Aug 11, 2018 02:20:32.430 [13244] ERROR - [MI] Error sending packet: Invalid data found when processing input
Aug 11, 2018 02:20:32.431 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4"
Aug 11, 2018 02:20:32.435 [13244] DEBUG - [FFMPEG] - Statistics: 6034973 bytes read, 3 seeks
Aug 11, 2018 02:20:32.435 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4"
Aug 11, 2018 02:20:32.435 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4' for reading
Aug 11, 2018 02:20:32.435 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.436 [13244] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Aug 11, 2018 02:20:32.436 [13244] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Aug 11, 2018 02:20:32.436 [13244] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Aug 11, 2018 02:20:32.456 [13244] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 1000, duration: 74503010
Aug 11, 2018 02:20:32.474 [13244] DEBUG - [FFMPEG] - Offset DTS by 1000 to make first pts zero.
Aug 11, 2018 02:20:32.489 [13244] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Aug 11, 2018 02:20:32.490 [13244] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Aug 11, 2018 02:20:32.511 [13244] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 1024, duration: 298310016
Aug 11, 2018 02:20:32.511 [13244] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Aug 11, 2018 02:20:32.539 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5552352 bytes read:5572598 seeks:0 nb_streams:2
Aug 11, 2018 02:20:32.540 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.540 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.543 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:32.543 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:32.544 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:32.546 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.549 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.551 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.553 [13244] DEBUG - [FFMPEG] - demuxer injecting skip 1024 / discard 0
Aug 11, 2018 02:20:32.553 [13244] DEBUG - [FFMPEG] - skip 1024 / discard 0 samples due to side data
Aug 11, 2018 02:20:32.554 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:32.554 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 5555180 bytes read:5572598 seeks:0 frames:3
Aug 11, 2018 02:20:32.554 [13244] DEBUG - Creating C:\Users\Lunar\AppData\Local\Plex Media Server\Media\localhost\5\96cfa1473aa9acc0fdcff7a1feb0098841075b1.bundle\Contents\Art\art1.jpg (50.0%, 1280x720).
Aug 11, 2018 02:20:32.555 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.555 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.556 [13244] ERROR - [FFMPEG] - Invalid NAL unit size (0 > 82183).
Aug 11, 2018 02:20:32.556 [13244] ERROR - [FFMPEG] - Error splitting the input into NAL units.
Aug 11, 2018 02:20:32.556 [13244] ERROR - [MI] Error sending packet: Invalid data found when processing input
Aug 11, 2018 02:20:32.557 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.557 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.558 [13244] ERROR - [FFMPEG] - Invalid NAL unit size (0 > 124711).
Aug 11, 2018 02:20:32.558 [13244] ERROR - [FFMPEG] - Error splitting the input into NAL units.
Aug 11, 2018 02:20:32.558 [13244] ERROR - [MI] Error sending packet: Invalid data found when processing input
Aug 11, 2018 02:20:32.559 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.559 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.560 [13244] ERROR - [FFMPEG] - Invalid NAL unit size (0 > 243415).
Aug 11, 2018 02:20:32.560 [13244] ERROR - [FFMPEG] - Error splitting the input into NAL units.
Aug 11, 2018 02:20:32.560 [13244] ERROR - [MI] Error sending packet: Invalid data found when processing input
Aug 11, 2018 02:20:32.560 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\10 Cloverfield Lane\10 Cloverfield Lane.mp4"
Aug 11, 2018 02:20:32.564 [13244] DEBUG - [FFMPEG] - Statistics: 6034973 bytes read, 3 seeks
Aug 11, 2018 02:20:32.567 [13244] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Aug 11, 2018 02:20:32.567 [13244] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Aug 11, 2018 02:20:32.580 [13244] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Aug 11, 2018 02:20:32.581 [13244] DEBUG - Updating metadata item (save) (10 Cloverfield Lane) with ID 1
Aug 11, 2018 02:20:32.587 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.599 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.599 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.603 [13244] DEBUG - It took 15.625000 ms to retrieve 202 items.
Aug 11, 2018 02:20:32.613 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.614 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.627 [13244] DEBUG - Analyzing media parts for item 306 (Star Wars: Episode Vll The Force Awakens): 306
Aug 11, 2018 02:20:32.629 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.631 [13244] DEBUG - [ID 306] Media part analysis: F:\Videos\Movies\Star Wars Episode VII\Star Wars Episode VII The Force Awakens.mkv
Aug 11, 2018 02:20:32.633 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\Star Wars Episode VII\Star Wars Episode VII The Force Awakens.mkv"
Aug 11, 2018 02:20:32.633 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\Star Wars Episode VII\Star Wars Episode VII The Force Awakens.mkv' for reading
Aug 11, 2018 02:20:32.633 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.652 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:32.653 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.653 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.653 [13244] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.653 [13244] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.653 [13244] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.654 [13244] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.654 [13244] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.655 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 71047 bytes read:98304 seeks:0 nb_streams:11
Aug 11, 2018 02:20:32.655 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.655 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.660 [13244] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=24550
Aug 11, 2018 02:20:32.660 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.660 [13244] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=24548
Aug 11, 2018 02:20:32.661 [13244] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Aug 11, 2018 02:20:32.661 [13244] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=24522
Aug 11, 2018 02:20:32.661 [13244] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Aug 11, 2018 02:20:32.661 [13244] DEBUG - [FFMPEG] - marker=ed avail_size_in_buf=24503
Aug 11, 2018 02:20:32.661 [13244] DEBUG - [FFMPEG] - marker parser used 43 bytes (344 bits)
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=24457
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=24441
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - index=0
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - qscale[0]: 0
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - index=1
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - qscale[1]: 0
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=24307
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - sof0: picture: 1067x600
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Aug 11, 2018 02:20:32.662 [13244] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - pix fmt id 11111100
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=24288
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - escaping removed 91 bytes
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=24087
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker parser used 23996 bytes (191968 bits)
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Aug 11, 2018 02:20:32.663 [13244] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=5035
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=5033
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=5007
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=4988
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=4972
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - index=0
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - qscale[0]: 0
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - index=1
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - qscale[1]: 0
Aug 11, 2018 02:20:32.664 [13244] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=4838
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - sof0: picture: 120x176
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - pix fmt id 11111100
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=4819
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.665 [13244] DEBUG - [FFMPEG] - escaping removed 17 bytes
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=4679
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker parser used 4662 bytes (37296 bits)
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=8560
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=8558
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=8532
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=ed avail_size_in_buf=8513
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker parser used 43 bytes (344 bits)
Aug 11, 2018 02:20:32.666 [13244] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=8467
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=8451
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - index=0
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - qscale[0]: 0
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - index=1
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - qscale[1]: 0
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=8317
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - sof0: picture: 213x120
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Aug 11, 2018 02:20:32.667 [13244] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - pix fmt id 11111100
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=8298
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - escaping removed 28 bytes
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=8136
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker parser used 8108 bytes (64864 bits)
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Aug 11, 2018 02:20:32.668 [13244] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=23752
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=23750
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=23724
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=23705
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=23689
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - index=0
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - qscale[0]: 0
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - index=1
Aug 11, 2018 02:20:32.669 [13244] DEBUG - [FFMPEG] - qscale[1]: 0
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=23555
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - sof0: picture: 600x882
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - pix fmt id 11111100
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=23536
Aug 11, 2018 02:20:32.670 [13244] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Aug 11, 2018 02:20:32.671 [13244] DEBUG - [FFMPEG] - escaping removed 102 bytes
Aug 11, 2018 02:20:32.671 [13244] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=23337
Aug 11, 2018 02:20:32.671 [13244] DEBUG - [FFMPEG] - marker parser used 23235 bytes (185880 bits)
Aug 11, 2018 02:20:32.671 [13244] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Aug 11, 2018 02:20:32.671 [13244] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Aug 11, 2018 02:20:32.672 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.672 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.672 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:32.673 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:32.673 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:32.676 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.684 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.687 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.689 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.694 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.700 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.706 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.708 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.712 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.716 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.722 [13244] DEBUG - [FFMPEG] - first_dts 292 not matching first dts NOPTS (pts 0, duration 41) in the queue
Aug 11, 2018 02:20:32.732 [13244] WARN - [FFMPEG] - Could not find codec parameters for stream 4 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Aug 11, 2018 02:20:32.732 [13244] WARN - [FFMPEG] - Could not find codec parameters for stream 5 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Aug 11, 2018 02:20:32.733 [13244] WARN - [FFMPEG] - Could not find codec parameters for stream 6 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Aug 11, 2018 02:20:32.733 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2560393 bytes read:2576725 seeks:0 frames:601
Aug 11, 2018 02:20:32.733 [13244] DEBUG - [MI]  * 89332df69d0e0148b14f8ce537d89ccd118100bd [mkv h264/dca] Duration: 8286699ms, 1920x800 (2.400000) 23.976fps, bitrate=15044kbps, audio channels=8, optimizedForStreaming=0 ("F:\Videos\Movies\Star Wars Episode VII\Star Wars Episode VII The Force Awakens.mkv")
Aug 11, 2018 02:20:32.734 [13244] DEBUG - [MI] Importing 50 media chapters.
Aug 11, 2018 02:20:32.734 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:32.737 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\Star Wars Episode VII\Star Wars Episode VII The Force Awakens.mkv"
Aug 11, 2018 02:20:32.742 [13244] DEBUG - [FFMPEG] - Statistics: 2576725 bytes read, 0 seeks
Aug 11, 2018 02:20:32.744 [13244] DEBUG - Committing media stream changes for part 306
Aug 11, 2018 02:20:32.749 [13244] DEBUG - Updating media item 306, size=15583164328, metadata_item_id=306
Aug 11, 2018 02:20:32.749 [13244] DEBUG - Updating part with ID=306 [F:\Videos\Movies\Star Wars Episode VII\Star Wars Episode VII The Force Awakens.mkv]
Aug 11, 2018 02:20:32.755 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=306&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.758 [13244] DEBUG - Analyzing media parts for item 11774 (Wild Horses): 17241
Aug 11, 2018 02:20:32.760 [13244] DEBUG - [ID 17319] Media part analysis: F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 19 - Wild Horses (1080p x265 10bit Joy).mkv
Aug 11, 2018 02:20:32.761 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 19 - Wild Horses (1080p x265 10bit Joy).mkv"
Aug 11, 2018 02:20:32.761 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 19 - Wild Horses (1080p x265 10bit Joy).mkv' for reading
Aug 11, 2018 02:20:32.761 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.767 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=306&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.767 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=306&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.781 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=306&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.781 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=306&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.782 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:32.788 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.788 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.789 [13244] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.789 [13244] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.789 [13244] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.789 [13244] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.790 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 196334 bytes read:231137 seeks:2 nb_streams:8
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - Decoding VPS
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - Main 10 profile bitstream
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - Decoding SPS
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - Main 10 profile bitstream
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - Decoding VUI
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.791 [13244] DEBUG - [FFMPEG] - Decoding PPS
Aug 11, 2018 02:20:32.792 [13244] DEBUG - [FFMPEG] - nal_unit_type: 39(SEI_PREFIX), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:32.792 [13244] DEBUG - [FFMPEG] - Decoding SEI
Aug 11, 2018 02:20:32.792 [13244] DEBUG - [FFMPEG] - Skipped PREFIX SEI 5
Aug 11, 2018 02:20:32.795 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=306&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.799 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:32.800 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 212348 bytes read:263905 seeks:2 frames:19
Aug 11, 2018 02:20:32.800 [13244] DEBUG - [MI]  * 4f6217a80b0dcfc33e5c411473f2409876d6131a [mkv hevc/aac] Duration: 1478299ms, 1440x1080 (1.333333) 23.976fps, bitrate=1187kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 19 - Wild Horses (1080p x265 10bit Joy).mkv")
Aug 11, 2018 02:20:32.801 [13244] DEBUG - [MI] Importing 5 media chapters.
Aug 11, 2018 02:20:32.802 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 19 - Wild Horses (1080p x265 10bit Joy).mkv"
Aug 11, 2018 02:20:32.803 [13244] DEBUG - [FFMPEG] - Statistics: 263905 bytes read, 2 seeks
Aug 11, 2018 02:20:32.805 [13244] DEBUG - Updating media item 17241, size=219413946, metadata_item_id=11774
Aug 11, 2018 02:20:32.806 [13244] DEBUG - Updating part with ID=17319 [F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 19 - Wild Horses (1080p x265 10bit Joy).mkv]
Aug 11, 2018 02:20:32.812 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11774&metadataType=4&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.819 [13244] DEBUG - It took 31.250000 ms to retrieve 131 items.
Aug 11, 2018 02:20:32.835 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11774&metadataType=4&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.835 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11774&metadataType=4&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.845 [13244] DEBUG - Analyzing media parts for item 56 (Captain America: The Winter Soldier): 56
Aug 11, 2018 02:20:32.847 [13244] DEBUG - [ID 56] Media part analysis: F:\Videos\Movies\Captain America The Winter Soldier\Captain America The Winter Soldier.mkv
Aug 11, 2018 02:20:32.849 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11774&metadataType=4&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.849 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\Captain America The Winter Soldier\Captain America The Winter Soldier.mkv"
Aug 11, 2018 02:20:32.849 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\Captain America The Winter Soldier\Captain America The Winter Soldier.mkv' for reading
Aug 11, 2018 02:20:32.849 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.849 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11774&metadataType=4&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.861 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11774&metadataType=4&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.861 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:32.865 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.866 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.866 [13244] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:32.866 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5810 bytes read:33985 seeks:2 nb_streams:3
Aug 11, 2018 02:20:32.867 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.867 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.869 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:32.869 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:32.869 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:32.869 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:32.869 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:32.874 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.877 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.880 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:32.883 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:32.891 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.898 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.907 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.912 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.917 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.923 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:32.929 [13244] DEBUG - [FFMPEG] - first_dts 292 not matching first dts NOPTS (pts 0, duration 41) in the queue
Aug 11, 2018 02:20:32.947 [13244] WARN - [FFMPEG] - Could not find codec parameters for stream 2 (Subtitle: hdmv_pgs_subtitle (pgssub)): unspecified size
Consider increasing the value for the 'analyzeduration' and 'probesize' options
Aug 11, 2018 02:20:32.947 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2152201 bytes read:2207374 seeks:2 frames:590
Aug 11, 2018 02:20:32.947 [13244] DEBUG - [MI]  * cad9d2244f2ff544b68afebed5b0308c11ba8817 [mkv h264/dca] Duration: 8154198ms, 1920x800 (2.400000) 23.976fps, bitrate=4721kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Movies\Captain America The Winter Soldier\Captain America The Winter Soldier.mkv")
Aug 11, 2018 02:20:32.948 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:32.948 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\Captain America The Winter Soldier\Captain America The Winter Soldier.mkv"
Aug 11, 2018 02:20:32.953 [13244] DEBUG - [FFMPEG] - Statistics: 2207374 bytes read, 2 seeks
Aug 11, 2018 02:20:32.955 [13244] DEBUG - Updating media item 56, size=4812994025, metadata_item_id=56
Aug 11, 2018 02:20:32.956 [13244] DEBUG - Updating part with ID=56 [F:\Videos\Movies\Captain America The Winter Soldier\Captain America The Winter Soldier.mkv]
Aug 11, 2018 02:20:32.962 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:32.974 [13244] DEBUG - Analyzing media parts for item 11764 (Jamming with Edward): 17231
Aug 11, 2018 02:20:32.974 [5380] ERROR - Error issuing curl_easy_perform(handle): 7
Aug 11, 2018 02:20:32.974 [5380] WARN - HTTP error requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=analyzing (0, No error) (Failed connect to 127.0.0.1:32400; No error)
Aug 11, 2018 02:20:32.975 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:32.976 [13244] DEBUG - [ID 17309] Media part analysis: F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 09 - Jamming with Edward (1080p x265 10bit Joy).mkv
Aug 11, 2018 02:20:32.978 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 09 - Jamming with Edward (1080p x265 10bit Joy).mkv"
Aug 11, 2018 02:20:32.978 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 09 - Jamming with Edward (1080p x265 10bit Joy).mkv' for reading
Aug 11, 2018 02:20:32.978 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:32.984 [5380] ERROR - Error issuing curl_easy_perform(handle): 7
Aug 11, 2018 02:20:32.984 [5380] WARN - HTTP error requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=thumbnailing (0, No error) (Failed connect to 127.0.0.1:32400; No error)
Aug 11, 2018 02:20:32.985 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:32.993 [5380] ERROR - Error issuing curl_easy_perform(handle): 7
Aug 11, 2018 02:20:32.994 [5380] WARN - HTTP error requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=56&metadataType=1&state=-1&mediaState=idle (0, No error) (Failed connect to 127.0.0.1:32400; No error)
Aug 11, 2018 02:20:32.994 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:33.003 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.003 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.003 [13244] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.003 [13244] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.003 [13244] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.004 [13244] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.005 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 196286 bytes read:231091 seeks:2 nb_streams:8
Aug 11, 2018 02:20:33.005 [13244] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:33.005 [13244] DEBUG - [FFMPEG] - Decoding VPS
Aug 11, 2018 02:20:33.005 [13244] DEBUG - [FFMPEG] - Main 10 profile bitstream
Aug 11, 2018 02:20:33.005 [13244] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - Decoding SPS
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - Main 10 profile bitstream
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - Decoding VUI
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - Decoding PPS
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - nal_unit_type: 39(SEI_PREFIX), nuh_layer_id: 0, temporal_id: 0
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - Decoding SEI
Aug 11, 2018 02:20:33.006 [13244] DEBUG - [FFMPEG] - Skipped PREFIX SEI 5
Aug 11, 2018 02:20:33.012 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:33.013 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 209166 bytes read:263859 seeks:2 frames:20
Aug 11, 2018 02:20:33.013 [13244] DEBUG - [MI]  * 3512053bf916f65614d096bdf663ecd517e2007b [mkv hevc/aac] Duration: 1475220ms, 1440x1080 (1.333333) 23.976fps, bitrate=1194kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 09 - Jamming with Edward (1080p x265 10bit Joy).mkv")
Aug 11, 2018 02:20:33.014 [13244] DEBUG - [MI] Importing 5 media chapters.
Aug 11, 2018 02:20:33.015 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 09 - Jamming with Edward (1080p x265 10bit Joy).mkv"
Aug 11, 2018 02:20:33.016 [13244] DEBUG - [FFMPEG] - Statistics: 263859 bytes read, 2 seeks
Aug 11, 2018 02:20:33.018 [13244] DEBUG - Updating media item 17231, size=220268725, metadata_item_id=11764
Aug 11, 2018 02:20:33.018 [13244] DEBUG - Updating part with ID=17309 [F:\Videos\Anime (Dubbed)\Cowboy Bebop\Cowboy Bebop 09 - Jamming with Edward (1080p x265 10bit Joy).mkv]
Aug 11, 2018 02:20:33.023 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11764&metadataType=4&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:33.035 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11764&metadataType=4&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:33.036 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11764&metadataType=4&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:33.047 [13244] DEBUG - Analyzing media parts for item 316 (Swiss Army Man): 316
Aug 11, 2018 02:20:33.048 [13244] DEBUG - [ID 316] Media part analysis: F:\Videos\Movies\Swiss Army Man\Swiss Army Man.mkv
Aug 11, 2018 02:20:33.050 [13244] DEBUG - [MI] Opening input file: "F:\Videos\Movies\Swiss Army Man\Swiss Army Man.mkv"
Aug 11, 2018 02:20:33.050 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11764&metadataType=4&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:33.050 [13244] DEBUG - [FFMPEG] - Opening 'F:\Videos\Movies\Swiss Army Man\Swiss Army Man.mkv' for reading
Aug 11, 2018 02:20:33.051 [13244] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Aug 11, 2018 02:20:33.051 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11764&metadataType=4&state=-1&mediaState=idle
Aug 11, 2018 02:20:33.063 [5380] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=7&metadataItemID=11764&metadataType=4&state=-1&mediaState=idle
Aug 11, 2018 02:20:33.066 [13244] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Aug 11, 2018 02:20:33.069 [13244] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.069 [13244] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Aug 11, 2018 02:20:33.069 [13244] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6572 bytes read:33585 seeks:2 nb_streams:2
Aug 11, 2018 02:20:33.070 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:33.070 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:33.072 [13244] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Aug 11, 2018 02:20:33.072 [13244] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Aug 11, 2018 02:20:33.072 [13244] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Aug 11, 2018 02:20:33.073 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:33.073 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:33.073 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:33.073 [13244] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Aug 11, 2018 02:20:33.073 [13244] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Aug 11, 2018 02:20:33.076 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:33.078 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.078 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.078 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.079 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.081 [13244] DEBUG - [FFMPEG] - no picture 
Aug 11, 2018 02:20:33.083 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.083 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.084 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.084 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.090 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.090 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.090 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.090 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.097 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.097 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.097 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.097 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.105 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.105 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.106 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.106 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.111 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.111 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.111 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.111 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Aug 11, 2018 02:20:33.117 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.117 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.117 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.117 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.120 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.120 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.120 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.120 [13244] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Aug 11, 2018 02:20:33.124 [13244] DEBUG - [FFMPEG] - All info found
Aug 11, 2018 02:20:33.124 [13244] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 57176 bytes read:99121 seeks:2 frames:58
Aug 11, 2018 02:20:33.124 [13244] DEBUG - [MI]  * ebda6f0261266045e1f991129cc0ac19cb518c77 [mkv h264/dca] Duration: 5843046ms, 1920x800 (2.400000) 23.976fps, bitrate=3605kbps, audio channels=6, optimizedForStreaming=0 ("F:\Videos\Movies\Swiss Army Man\Swiss Army Man.mkv")
Aug 11, 2018 02:20:33.125 [13244] DEBUG - [MI] Importing 16 media chapters.
Aug 11, 2018 02:20:33.125 [13244] DEBUG - [MI] Chapters had generic titles, clearing.
Aug 11, 2018 02:20:33.127 [13244] DEBUG - [MI] Closing input file: "F:\Videos\Movies\Swiss Army Man\Swiss Army Man.mkv"
Aug 11, 2018 02:20:33.130 [13244] DEBUG - [FFMPEG] - Statistics: 99121 bytes read, 2 seeks
Aug 11, 2018 02:20:33.131 [13244] DEBUG - Updating media item 316, size=2633568659, metadata_item_id=316
Aug 11, 2018 02:20:33.131 [13244] DEBUG - Updating part with ID=316 [F:\Videos\Movies\Swiss Army Man\Swiss Army Man.mkv]
Aug 11, 2018 02:20:33.137 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=316&metadataType=1&state=-1&mediaState=analyzing
Aug 11, 2018 02:20:33.146 [5380] ERROR - Error issuing curl_easy_perform(handle): 7
Aug 11, 2018 02:20:33.146 [5380] WARN - HTTP error requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=316&metadataType=1&state=-1&mediaState=analyzing (0, No error) (Failed connect to 127.0.0.1:32400; No error)
Aug 11, 2018 02:20:33.147 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=316&metadataType=1&state=-1&mediaState=thumbnailing
Aug 11, 2018 02:20:33.155 [5380] ERROR - Error issuing curl_easy_perform(handle): 7
Aug 11, 2018 02:20:33.156 [5380] WARN - HTTP error requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=316&metadataType=1&state=-1&mediaState=thumbnailing (0, No error) (Failed connect to 127.0.0.1:32400; No error)
Aug 11, 2018 02:20:33.156 [5380] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=316&metadataType=1&state=-1&mediaState=idle
Aug 11, 2018 02:20:33.165 [5380] ERROR - Error issuing curl_easy_perform(handle): 7
Aug 11, 2018 02:20:33.165 [5380] WARN - HTTP error requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=316&metadataType=1&state=-1&mediaState=idle (0, No error) (Failed connect to 127.0.0.1:32400; No error)
