Sep 02, 2018 04:50:58.047 [0x7f4cfd256700] INFO - Plex Media Scanner v1.13.5.5332-21ab172de - ubuntu PC x86_64 - build: linux-ubuntu-x86_64 - GMT -05:00
Sep 02, 2018 04:50:58.047 [0x7f4cfd256700] INFO - Linux version: 4.4.59+ (#23739 SMP PREEMPT Tue Jul 10 00:18:17 CST 2018), language: en-US
Sep 02, 2018 04:50:58.047 [0x7f4cfd256700] INFO - Processor Intel(R) Celeron(R) CPU J3455 @ 1.50GHz
Sep 02, 2018 04:50:58.047 [0x7f4cfd256700] INFO - /volume1/@appstore/Plex Media Server/Plex Media Scanner --analyze --item 3856,3547,3527,195,2707,3554,3416,3413,3419,3615 --log-file-suffix  Analysis
Sep 02, 2018 04:50:58.066 [0x7f4d0959b800] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Sep 02, 2018 04:50:58.328 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3856 (Rick Potion #9): 7657
Sep 02, 2018 04:50:58.331 [0x7f4d0959b800] DEBUG - [ID 7657] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Rick and Morty/Season 1/Rick and Morty S01E06 - Rick Potion #9.mkv
Sep 02, 2018 04:50:58.331 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Rick and Morty/Season 1/Rick and Morty S01E06 - Rick Potion #9.mkv"
Sep 02, 2018 04:50:58.331 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Rick and Morty/Season 1/Rick and Morty S01E06 - Rick Potion #9.mkv' for reading
Sep 02, 2018 04:50:58.332 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:50:58.380 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:50:58.397 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:58.397 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:58.397 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:58.398 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6002 bytes read:34101 seeks:2 nb_streams:3
Sep 02, 2018 04:50:58.399 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:58.399 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:58.401 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:58.401 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:58.402 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:58.402 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:58.402 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:50:58.402 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:50:58.402 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:50:58.404 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:58.406 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:58.407 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:58.409 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:58.413 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:58.417 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:58.422 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:58.424 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:58.427 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:58.431 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:58.435 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:50:58.435 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 48429 bytes read:99637 seeks:2 frames:26
Sep 02, 2018 04:50:58.437 [0x7f4d0959b800] DEBUG - [MI]  * 612bef57cc3f0e6bf8dac23d161aa672180af748 [mkv h264/ac3] Duration: 1288896ms, 1280x720 (1.777778) 23.976fps, bitrate=3217kbps, audio channels=6, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Rick and Morty/Season 1/Rick and Morty S01E06 - Rick Potion #9.mkv")
Sep 02, 2018 04:50:58.438 [0x7f4d0959b800] DEBUG - [MI] Importing 5 media chapters.
Sep 02, 2018 04:50:58.439 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:50:58.442 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Rick and Morty/Season 1/Rick and Morty S01E06 - Rick Potion #9.mkv"
Sep 02, 2018 04:50:58.445 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 99637 bytes read, 2 seeks
Sep 02, 2018 04:50:58.448 [0x7f4d0959b800] DEBUG - Updating media item 7657, size=518428192, metadata_item_id=3856
Sep 02, 2018 04:50:58.448 [0x7f4d0959b800] DEBUG - Updating part with ID=7657 [/volume1/Plex/Library/Shared Videos/TV/Rick and Morty/Season 1/Rick and Morty S01E06 - Rick Potion #9.mkv]
Sep 02, 2018 04:50:58.573 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3856&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:58.576 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3856&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:58.577 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3856&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:58.579 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3856&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:58.579 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3547 (Pinkenstein): 7259
Sep 02, 2018 04:50:58.580 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3856&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:58.581 [0x7f4d0959b800] DEBUG - [ID 7259] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v
Sep 02, 2018 04:50:58.582 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v"
Sep 02, 2018 04:50:58.582 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v' for reading
Sep 02, 2018 04:50:58.582 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3856&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:58.582 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:50:58.620 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:50:58.620 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:50:58.627 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:50:58.639 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7200, duration: 31824000
Sep 02, 2018 04:50:58.640 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7200 to make first pts zero.
Sep 02, 2018 04:50:58.642 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:50:58.642 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:50:58.658 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 16969728
Sep 02, 2018 04:50:58.659 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:50:58.659 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 135235633 bytes read:320802 seeks:3 nb_streams:3
Sep 02, 2018 04:50:58.659 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:58.660 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:58.664 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:50:58.664 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:50:58.664 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:50:58.665 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:58.666 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:58.667 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 986 bytes read:353570 seeks:4 frames:3
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v" for MP4 atom parsing
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 134980327 at offset 40
Sep 02, 2018 04:50:58.668 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 255266 at offset 134980367
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 121480 at offset 134980507
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 133095 at offset 135101987
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 439 at offset 135235082
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 121324 at offset 134980663
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 121239 at offset 134980748
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 121175 at offset 134980812
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 134980643
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 134980651
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 132917 at offset 135102143
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 132838 at offset 135102222
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 132778 at offset 135102282
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 135102123
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 135102131
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 339 at offset 135235182
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 251 at offset 135235270
Sep 02, 2018 04:50:58.669 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 175 at offset 135235346
Sep 02, 2018 04:50:58.670 [0x7f4d0959b800] DEBUG - [MI]  * d283cb8f4e5e582483e5acefb81d883a0f9bff71 [mp4 h264/aac] Duration: 353600ms, 720x576 (1.777778) 25.000fps, bitrate=3059kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v")
Sep 02, 2018 04:50:58.671 [0x7f4d0959b800] DEBUG - [MI] Importing 1 media chapters.
Sep 02, 2018 04:50:58.671 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:50:58.672 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:58.672 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:58.675 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:58.675 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Pinkenstein) with ID 3547
Sep 02, 2018 04:50:58.771 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:50:58.773 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v"
Sep 02, 2018 04:50:58.773 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:50:58.774 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 353570 bytes read, 4 seeks
Sep 02, 2018 04:50:58.776 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7259
Sep 02, 2018 04:50:58.832 [0x7f4d0959b800] DEBUG - Updating media item 7259, size=135235633, metadata_item_id=3547
Sep 02, 2018 04:50:58.833 [0x7f4d0959b800] DEBUG - Updating part with ID=7259 [/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-30.m4v]
Sep 02, 2018 04:50:58.933 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3547&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:58.935 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3547&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:58.935 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3547&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:58.937 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3547&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:58.938 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3547&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:58.939 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3527 (Department Store Pink-erton): 7239
Sep 02, 2018 04:50:58.940 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3547&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:58.941 [0x7f4d0959b800] DEBUG - [ID 7239] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v
Sep 02, 2018 04:50:58.951 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v"
Sep 02, 2018 04:50:58.952 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v' for reading
Sep 02, 2018 04:50:58.952 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:50:58.988 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:50:58.988 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:50:58.996 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:50:59.011 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7200, duration: 33030000
Sep 02, 2018 04:50:59.012 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7200 to make first pts zero.
Sep 02, 2018 04:50:59.014 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:50:59.014 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:50:59.016 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 17613840
Sep 02, 2018 04:50:59.017 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:50:59.017 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 98406080 bytes read:341422 seeks:3 nb_streams:3
Sep 02, 2018 04:50:59.018 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.018 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.020 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:50:59.020 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:50:59.020 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:50:59.020 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.021 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.022 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 986 bytes read:374190 seeks:4 frames:3
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v" for MP4 atom parsing
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 98130154 at offset 40
Sep 02, 2018 04:50:59.023 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 275886 at offset 98130194
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 137068 at offset 98130334
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 138127 at offset 98267402
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 439 at offset 98405529
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 136912 at offset 98130490
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 136827 at offset 98130575
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 136763 at offset 98130639
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 98130470
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 98130478
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 137949 at offset 98267558
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 137870 at offset 98267637
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 137810 at offset 98267697
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 98267538
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 98267546
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 339 at offset 98405629
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 251 at offset 98405717
Sep 02, 2018 04:50:59.024 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 175 at offset 98405793
Sep 02, 2018 04:50:59.025 [0x7f4d0959b800] DEBUG - [MI]  * b9cbf18e2d7dba400bc4a8a114133a1e0d3e1790 [mp4 h264/aac] Duration: 367000ms, 720x576 (1.777778) 25.000fps, bitrate=2145kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v")
Sep 02, 2018 04:50:59.026 [0x7f4d0959b800] DEBUG - [MI] Importing 1 media chapters.
Sep 02, 2018 04:50:59.026 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:50:59.027 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:59.027 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:59.029 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:59.030 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Department Store Pink-erton) with ID 3527
Sep 02, 2018 04:50:59.127 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:50:59.128 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v"
Sep 02, 2018 04:50:59.128 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:50:59.129 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 374190 bytes read, 4 seeks
Sep 02, 2018 04:50:59.131 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7239
Sep 02, 2018 04:50:59.221 [0x7f4d0959b800] DEBUG - Updating media item 7239, size=98406080, metadata_item_id=3527
Sep 02, 2018 04:50:59.221 [0x7f4d0959b800] DEBUG - Updating part with ID=7239 [/volume1/Plex/Library/Shared Videos/TV/Pink Panther/1/Video Ts-10.m4v]
Sep 02, 2018 04:50:59.295 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3527&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:59.297 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3527&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:59.297 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3527&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:59.299 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3527&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:59.300 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3527&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:59.302 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3527&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:59.367 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 195 (The Pool): 211
Sep 02, 2018 04:50:59.367 [0x7f4d0959b800] DEBUG - [ID 211] Media part analysis: /volume1/Plex/Library/Shared Videos/Movies/The Pool/The Pool.mkv
Sep 02, 2018 04:50:59.381 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/Movies/The Pool/The Pool.mkv"
Sep 02, 2018 04:50:59.381 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/Movies/The Pool/The Pool.mkv' for reading
Sep 02, 2018 04:50:59.381 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:50:59.435 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:50:59.456 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.456 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.456 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 739 bytes read:46914 seeks:2 nb_streams:2
Sep 02, 2018 04:50:59.456 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.457 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.458 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.458 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.458 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:50:59.458 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:50:59.458 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:50:59.459 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.460 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.461 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.462 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.464 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.465 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.467 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.468 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.470 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.471 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.473 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:50:59.473 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2891 bytes read:79682 seeks:2 frames:25
Sep 02, 2018 04:50:59.473 [0x7f4d0959b800] DEBUG - [MI]  * 9099b534486d385ed7068ba0c08922500ed1d1ed [mkv h264/aac] Duration: 5671874ms, 720x480 (1.777070) 23.976fps, bitrate=2350kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/Movies/The Pool/The Pool.mkv")
Sep 02, 2018 04:50:59.474 [0x7f4d0959b800] DEBUG - [MI] Importing 10 media chapters.
Sep 02, 2018 04:50:59.475 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:50:59.477 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/Movies/The Pool/The Pool.mkv"
Sep 02, 2018 04:50:59.479 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 79682 bytes read, 2 seeks
Sep 02, 2018 04:50:59.480 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 211
Sep 02, 2018 04:50:59.572 [0x7f4d0959b800] DEBUG - Updating media item 211, size=1666401643, metadata_item_id=195
Sep 02, 2018 04:50:59.572 [0x7f4d0959b800] DEBUG - Updating part with ID=211 [/volume1/Plex/Library/Shared Videos/Movies/The Pool/The Pool.mkv]
Sep 02, 2018 04:50:59.676 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=195&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:59.678 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=195&metadataType=1&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:59.678 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=195&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:59.680 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=195&metadataType=1&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:59.681 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=195&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 04:50:59.683 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=195&metadataType=1&state=-1&mediaState=idle
Sep 02, 2018 04:50:59.683 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 2707 (Inflatable): 6412,8496
Sep 02, 2018 04:50:59.685 [0x7f4d0959b800] DEBUG - [ID 8513] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/orig/Better.Call.Saul.S02E07.720p.BluRay.X264-REWARD.mkv
Sep 02, 2018 04:50:59.686 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/orig/Better.Call.Saul.S02E07.720p.BluRay.X264-REWARD.mkv"
Sep 02, 2018 04:50:59.686 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/orig/Better.Call.Saul.S02E07.720p.BluRay.X264-REWARD.mkv' for reading
Sep 02, 2018 04:50:59.686 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:50:59.703 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:50:59.712 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.712 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.712 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.712 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.713 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6032 bytes read:34290 seeks:2 nb_streams:4
Sep 02, 2018 04:50:59.713 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.713 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.714 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.714 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.714 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:50:59.714 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:50:59.714 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:50:59.716 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.719 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.720 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.722 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.726 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.730 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.735 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.737 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.740 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.743 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.747 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:50:59.747 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 104050 bytes read:132594 seeks:2 frames:58
Sep 02, 2018 04:50:59.748 [0x7f4d0959b800] DEBUG - [MI]  * afdfe49e4bb646c054c56fcd8ac65aee2402af77 [mkv h264/dca] Duration: 2533163ms, 1280x720 (1.777778) 23.976fps, bitrate=7402kbps, audio channels=6, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/orig/Better.Call.Saul.S02E07.720p.BluRay.X264-REWARD.mkv")
Sep 02, 2018 04:50:59.749 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:50:59.749 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:50:59.751 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/orig/Better.Call.Saul.S02E07.720p.BluRay.X264-REWARD.mkv"
Sep 02, 2018 04:50:59.753 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 132594 bytes read, 2 seeks
Sep 02, 2018 04:50:59.756 [0x7f4d0959b800] DEBUG - Updating media item 6412, size=2343846010, metadata_item_id=2707
Sep 02, 2018 04:50:59.757 [0x7f4d0959b800] DEBUG - Updating part with ID=8513 [/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/orig/Better.Call.Saul.S02E07.720p.BluRay.X264-REWARD.mkv]
Sep 02, 2018 04:50:59.855 [0x7f4d0959b800] DEBUG - [ID 8504] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/Better.Call.Saul.Season.2.720p.BluRay.x264.ShAaNiG/Better.Call.Saul.S02E07.720p.BluRay.x264.ShAaNiG.mkv
Sep 02, 2018 04:50:59.855 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:59.855 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/Better.Call.Saul.Season.2.720p.BluRay.x264.ShAaNiG/Better.Call.Saul.S02E07.720p.BluRay.x264.ShAaNiG.mkv"
Sep 02, 2018 04:50:59.855 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/Better.Call.Saul.Season.2.720p.BluRay.x264.ShAaNiG/Better.Call.Saul.S02E07.720p.BluRay.x264.ShAaNiG.mkv' for reading
Sep 02, 2018 04:50:59.855 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:50:59.857 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:50:59.857 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:59.860 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:50:59.860 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:59.862 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:50:59.894 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:50:59.903 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.904 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:50:59.904 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5563 bytes read:33651 seeks:2 nb_streams:2
Sep 02, 2018 04:50:59.904 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.904 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.905 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.906 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.906 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:50:59.906 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:50:59.906 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:50:59.906 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:50:59.906 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:50:59.908 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:50:59.910 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.913 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.917 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.921 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.925 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:50:59.927 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.930 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:50:59.934 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:50:59.934 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 11544 bytes read:66419 seeks:2 frames:17
Sep 02, 2018 04:50:59.934 [0x7f4d0959b800] DEBUG - [MI]  * 4e4332552e53002a62838324e5bfe71df6b2b510 [mkv h264/aac] Duration: 2533194ms, 1280x720 (1.777778) 23.976fps, bitrate=1241kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/Better.Call.Saul.Season.2.720p.BluRay.x264.ShAaNiG/Better.Call.Saul.S02E07.720p.BluRay.x264.ShAaNiG.mkv")
Sep 02, 2018 04:50:59.936 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:50:59.936 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:59.936 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:59.939 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:50:59.939 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Inflatable) with ID 2707
Sep 02, 2018 04:51:00.027 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:00.029 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:00.029 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'Inflatable' because something changed.
Sep 02, 2018 04:51:00.110 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.110 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.113 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.113 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Inflatable) with ID 2707
Sep 02, 2018 04:51:00.204 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/Better.Call.Saul.Season.2.720p.BluRay.x264.ShAaNiG/Better.Call.Saul.S02E07.720p.BluRay.x264.ShAaNiG.mkv"
Sep 02, 2018 04:51:00.205 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:00.206 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:00.207 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 66419 bytes read, 2 seeks
Sep 02, 2018 04:51:00.208 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 8504
Sep 02, 2018 04:51:00.277 [0x7f4d0959b800] DEBUG - Updating media item 8496, size=393064562, metadata_item_id=2707
Sep 02, 2018 04:51:00.277 [0x7f4d0959b800] DEBUG - Updating part with ID=8504 [/volume1/Plex/Library/Shared Videos/TV/Better Call Saul/Season 2/Better.Call.Saul.Season.2.720p.BluRay.x264.ShAaNiG/Better.Call.Saul.S02E07.720p.BluRay.x264.ShAaNiG.mkv]
Sep 02, 2018 04:51:00.376 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:00.378 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:00.379 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:00.381 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:00.382 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:00.382 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3554 (Wet and Wild Pinky): 7265
Sep 02, 2018 04:51:00.384 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=2707&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:00.384 [0x7f4d0959b800] DEBUG - [ID 7265] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v
Sep 02, 2018 04:51:00.384 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v"
Sep 02, 2018 04:51:00.384 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v' for reading
Sep 02, 2018 04:51:00.384 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:00.405 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:51:00.405 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:51:00.413 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:00.419 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7200, duration: 32616000
Sep 02, 2018 04:51:00.420 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7200 to make first pts zero.
Sep 02, 2018 04:51:00.422 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:51:00.422 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:00.424 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 17392656
Sep 02, 2018 04:51:00.426 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:00.427 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 120490386 bytes read:341626 seeks:3 nb_streams:3
Sep 02, 2018 04:51:00.427 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:00.427 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:00.429 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:00.429 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:00.429 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:00.430 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:00.431 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:00.432 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1023 bytes read:374394 seeks:4 frames:3
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v" for MP4 atom parsing
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 120214256 at offset 40
Sep 02, 2018 04:51:00.433 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 276090 at offset 120214296
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 139000 at offset 120214436
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 136399 at offset 120353436
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 439 at offset 120489835
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 138844 at offset 120214592
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 138759 at offset 120214677
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 138695 at offset 120214741
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 120214572
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 120214580
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 136221 at offset 120353592
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 136142 at offset 120353671
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 136082 at offset 120353731
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 120353572
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 120353580
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 339 at offset 120489935
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 251 at offset 120490023
Sep 02, 2018 04:51:00.434 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 175 at offset 120490099
Sep 02, 2018 04:51:00.435 [0x7f4d0959b800] DEBUG - [MI]  * 703dd2f265128b17025a36588c883709c533d401 [mp4 h264/aac] Duration: 362400ms, 720x576 (1.777778) 25.000fps, bitrate=2659kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v")
Sep 02, 2018 04:51:00.436 [0x7f4d0959b800] DEBUG - [MI] Importing 1 media chapters.
Sep 02, 2018 04:51:00.436 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:00.436 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.437 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.439 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.439 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Wet and Wild Pinky) with ID 3554
Sep 02, 2018 04:51:00.531 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:00.533 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v"
Sep 02, 2018 04:51:00.533 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:00.534 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 374394 bytes read, 4 seeks
Sep 02, 2018 04:51:00.536 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7265
Sep 02, 2018 04:51:00.621 [0x7f4d0959b800] DEBUG - Updating media item 7265, size=120490386, metadata_item_id=3554
Sep 02, 2018 04:51:00.621 [0x7f4d0959b800] DEBUG - Updating part with ID=7265 [/volume1/Plex/Library/Shared Videos/TV/Pink Panther/2/Video Ts-12.m4v]
Sep 02, 2018 04:51:00.706 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3554&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:00.708 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3554&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:00.709 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3554&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:00.710 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3554&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:00.711 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3554&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:00.713 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3554&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:00.713 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3416 (The Dirty Half Dozen): 7093,7115
Sep 02, 2018 04:51:00.715 [0x7f4d0959b800] DEBUG - [ID 7093] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward.mkv
Sep 02, 2018 04:51:00.716 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward.mkv"
Sep 02, 2018 04:51:00.716 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward.mkv' for reading
Sep 02, 2018 04:51:00.716 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:00.733 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:51:00.741 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:00.741 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:00.741 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:00.741 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:00.742 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6026 bytes read:34290 seeks:2 nb_streams:4
Sep 02, 2018 04:51:00.742 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:00.742 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:00.743 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:00.743 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:00.743 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:00.743 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:00.743 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:00.745 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:00.748 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:00.749 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:00.751 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:00.755 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:00.759 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:00.764 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:00.766 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:00.769 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:00.772 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:00.776 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:00.776 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 104033 bytes read:132594 seeks:2 frames:58
Sep 02, 2018 04:51:00.777 [0x7f4d0959b800] DEBUG - [MI]  * 63a02e400012d9c42ab0dfbc887f090c4c3db5e4 [mkv h264/dca] Duration: 2492118ms, 1280x720 (1.777778) 23.976fps, bitrate=7521kbps, audio channels=6, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward.mkv")
Sep 02, 2018 04:51:00.778 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:51:00.778 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:00.780 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'The Dirty Half Dozen' because something changed.
Sep 02, 2018 04:51:00.927 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.927 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.930 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:00.930 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (The Dirty Half Dozen) with ID 3416
Sep 02, 2018 04:51:01.016 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward.mkv"
Sep 02, 2018 04:51:01.016 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:01.017 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:01.018 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 132594 bytes read, 2 seeks
Sep 02, 2018 04:51:01.021 [0x7f4d0959b800] DEBUG - Updating media item 7093, size=2343212430, metadata_item_id=3416
Sep 02, 2018 04:51:01.021 [0x7f4d0959b800] DEBUG - Updating part with ID=7093 [/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward.mkv]
Sep 02, 2018 04:51:01.077 [0x7f4d0959b800] DEBUG - [ID 7115] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v
Sep 02, 2018 04:51:01.077 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:01.077 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v"
Sep 02, 2018 04:51:01.077 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v' for reading
Sep 02, 2018 04:51:01.077 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:01.079 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:01.079 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:01.081 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:01.081 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:01.083 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:01.094 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:51:01.094 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:51:01.106 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:01.139 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7470, duration: 224290350
Sep 02, 2018 04:51:01.145 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7470 to make first pts zero.
Sep 02, 2018 04:51:01.156 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:51:01.157 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:01.171 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 119620608
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.916667 0.005008
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.916667 0.012325
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 24.000000 0.000828
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 24.083333 0.015982
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 48.000000 0.003312
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.976024 0.000050
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 47.952048 0.000198
Sep 02, 2018 04:51:01.180 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 756733102 bytes read:2176878 seeks:3 nb_streams:3
Sep 02, 2018 04:51:01.181 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:01.181 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:01.182 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:01.182 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:01.183 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:01.184 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:01.186 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:01.187 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:01.189 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:01.189 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1083 bytes read:2209646 seeks:4 frames:3
Sep 02, 2018 04:51:01.189 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v" for MP4 atom parsing
Sep 02, 2018 04:51:01.189 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:51:01.190 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:51:01.190 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 754621720 at offset 40
Sep 02, 2018 04:51:01.190 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 2111342 at offset 754621760
Sep 02, 2018 04:51:01.191 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 1175536 at offset 754621900
Sep 02, 2018 04:51:01.191 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 935055 at offset 755797436
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 499 at offset 756732491
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 1175380 at offset 754622056
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 1175295 at offset 754622141
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 1175231 at offset 754622205
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 754622036
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 754622044
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 934877 at offset 755797592
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 934798 at offset 755797671
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 934738 at offset 755797731
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 755797572
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 755797580
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 399 at offset 756732591
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 311 at offset 756732679
Sep 02, 2018 04:51:01.192 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 235 at offset 756732755
Sep 02, 2018 04:51:01.193 [0x7f4d0959b800] DEBUG - [MI]  * fed8b92f5765a0e4917e3bcaa9dd8fe6f434df73 [mp4 h264/aac] Duration: 2492115ms, 1280x720 (1.777778) 23.976fps, bitrate=2429kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v")
Sep 02, 2018 04:51:01.194 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:51:01.194 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:01.196 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'The Dirty Half Dozen' because something changed.
Sep 02, 2018 04:51:01.321 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:01.321 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:01.323 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:01.324 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (The Dirty Half Dozen) with ID 3416
Sep 02, 2018 04:51:01.387 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v"
Sep 02, 2018 04:51:01.387 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:01.389 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 2209646 bytes read, 4 seeks
Sep 02, 2018 04:51:01.389 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:01.391 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7115
Sep 02, 2018 04:51:01.477 [0x7f4d0959b800] DEBUG - Updating media item 7115, size=756733102, metadata_item_id=3416
Sep 02, 2018 04:51:01.477 [0x7f4d0959b800] DEBUG - Updating part with ID=7115 [/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e19.720p.bluray.x264-reward-19.m4v]
Sep 02, 2018 04:51:01.566 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:01.568 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:01.569 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:01.571 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:01.571 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:01.573 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3416&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:01.574 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3413 (Afterlife): 7090,7112
Sep 02, 2018 04:51:01.576 [0x7f4d0959b800] DEBUG - [ID 7090] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward.mkv
Sep 02, 2018 04:51:01.576 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward.mkv"
Sep 02, 2018 04:51:01.576 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward.mkv' for reading
Sep 02, 2018 04:51:01.576 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:01.598 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6026 bytes read:34290 seeks:2 nb_streams:4
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:01.622 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:01.623 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:01.623 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:01.624 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:01.624 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:01.624 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:01.626 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:01.629 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:01.630 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:01.632 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:01.636 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:01.640 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:01.645 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:01.647 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:01.650 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:01.653 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:01.657 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:01.657 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 104032 bytes read:132594 seeks:2 frames:58
Sep 02, 2018 04:51:01.658 [0x7f4d0959b800] DEBUG - [MI]  * b7348edf6d641ca777b3eabb82d655dcc8529aa4 [mkv h264/dca] Duration: 2585718ms, 1280x720 (1.777778) 23.976fps, bitrate=7246kbps, audio channels=6, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward.mkv")
Sep 02, 2018 04:51:01.659 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:51:01.659 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:01.661 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'Afterlife' because something changed.
Sep 02, 2018 04:51:01.816 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:01.816 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:01.819 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:01.819 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Afterlife) with ID 3413
Sep 02, 2018 04:51:01.916 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward.mkv"
Sep 02, 2018 04:51:01.916 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:01.918 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:01.918 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 132594 bytes read, 2 seeks
Sep 02, 2018 04:51:01.921 [0x7f4d0959b800] DEBUG - Updating media item 7090, size=2342290230, metadata_item_id=3413
Sep 02, 2018 04:51:01.921 [0x7f4d0959b800] DEBUG - Updating part with ID=7090 [/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward.mkv]
Sep 02, 2018 04:51:02.006 [0x7f4d0959b800] DEBUG - [ID 7112] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v
Sep 02, 2018 04:51:02.006 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:02.006 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v"
Sep 02, 2018 04:51:02.006 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v' for reading
Sep 02, 2018 04:51:02.006 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:02.008 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:02.008 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:02.010 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:02.010 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:02.012 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:02.030 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:51:02.030 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:51:02.039 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:02.072 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7470, duration: 232713720
Sep 02, 2018 04:51:02.079 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7470 to make first pts zero.
Sep 02, 2018 04:51:02.091 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:51:02.091 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:02.105 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 124112928
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.916667 0.005008
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.916667 0.012325
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 24.000000 0.000828
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 24.083333 0.015982
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 48.000000 0.003312
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.976024 0.000050
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 47.952048 0.000198
Sep 02, 2018 04:51:02.113 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 776949182 bytes read:2272282 seeks:3 nb_streams:3
Sep 02, 2018 04:51:02.114 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:02.114 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:02.116 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:02.116 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:02.116 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:02.117 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:02.119 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:02.120 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:02.122 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:02.122 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1083 bytes read:2305050 seeks:4 frames:3
Sep 02, 2018 04:51:02.123 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v" for MP4 atom parsing
Sep 02, 2018 04:51:02.123 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:51:02.123 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:51:02.123 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 774742396 at offset 40
Sep 02, 2018 04:51:02.123 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 2206746 at offset 774742436
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 1235844 at offset 774742576
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 970151 at offset 775978420
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 499 at offset 776948571
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 1235688 at offset 774742732
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 1235603 at offset 774742817
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 1235539 at offset 774742881
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 774742712
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 774742720
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 969973 at offset 775978576
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 969894 at offset 775978655
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 969834 at offset 775978715
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 775978556
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 775978564
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 399 at offset 776948671
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 311 at offset 776948759
Sep 02, 2018 04:51:02.125 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 235 at offset 776948835
Sep 02, 2018 04:51:02.126 [0x7f4d0959b800] DEBUG - [MI]  * 04660560fee71f2afbf641b895efc42cf5b60757 [mp4 h264/aac] Duration: 2585708ms, 1280x720 (1.777778) 23.976fps, bitrate=2403kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v")
Sep 02, 2018 04:51:02.127 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:51:02.127 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:02.129 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'Afterlife' because something changed.
Sep 02, 2018 04:51:02.249 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:02.250 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:02.252 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:02.253 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (Afterlife) with ID 3413
Sep 02, 2018 04:51:02.387 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v"
Sep 02, 2018 04:51:02.387 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:02.389 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:02.389 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 2305050 bytes read, 4 seeks
Sep 02, 2018 04:51:02.391 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7112
Sep 02, 2018 04:51:02.465 [0x7f4d0959b800] DEBUG - Updating media item 7112, size=776949182, metadata_item_id=3413
Sep 02, 2018 04:51:02.466 [0x7f4d0959b800] DEBUG - Updating part with ID=7112 [/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e16.720p.bluray.x264-reward-16.m4v]
Sep 02, 2018 04:51:02.539 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:02.541 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:02.542 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:02.543 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:02.544 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:02.546 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3413&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:02.547 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3419 (S.O.S. (2)): 7096,7118
Sep 02, 2018 04:51:02.549 [0x7f4d0959b800] DEBUG - [ID 7096] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward.mkv
Sep 02, 2018 04:51:02.549 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward.mkv"
Sep 02, 2018 04:51:02.549 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward.mkv' for reading
Sep 02, 2018 04:51:02.549 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:02.583 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Sep 02, 2018 04:51:02.603 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:02.603 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:02.603 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:02.603 [0x7f4d0959b800] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Sep 02, 2018 04:51:02.604 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6026 bytes read:34290 seeks:2 nb_streams:4
Sep 02, 2018 04:51:02.604 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:02.604 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:02.605 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:02.605 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:02.605 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:02.605 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:02.605 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:02.607 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:02.610 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:02.611 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:02.613 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:02.617 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:02.621 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:02.626 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:02.628 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:02.630 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:02.633 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Sep 02, 2018 04:51:02.638 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:02.638 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 104032 bytes read:132594 seeks:2 frames:58
Sep 02, 2018 04:51:02.638 [0x7f4d0959b800] DEBUG - [MI]  * 501cdc29505d64c09a38169da7a33dc03d3495fa [mkv h264/dca] Duration: 2585760ms, 1280x720 (1.777778) 23.976fps, bitrate=7248kbps, audio channels=6, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward.mkv")
Sep 02, 2018 04:51:02.640 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:51:02.640 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:02.642 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'S.O.S. (2)' because something changed.
Sep 02, 2018 04:51:02.754 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:02.754 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:02.757 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:02.757 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (S.O.S. (2)) with ID 3419
Sep 02, 2018 04:51:02.831 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward.mkv"
Sep 02, 2018 04:51:02.831 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:02.833 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:02.834 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 132594 bytes read, 2 seeks
Sep 02, 2018 04:51:02.836 [0x7f4d0959b800] DEBUG - Updating media item 7096, size=2342783367, metadata_item_id=3419
Sep 02, 2018 04:51:02.837 [0x7f4d0959b800] DEBUG - Updating part with ID=7096 [/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward.mkv]
Sep 02, 2018 04:51:02.920 [0x7f4d0959b800] DEBUG - [ID 7118] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v
Sep 02, 2018 04:51:02.920 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:02.921 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v"
Sep 02, 2018 04:51:02.921 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v' for reading
Sep 02, 2018 04:51:02.921 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:02.922 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:02.923 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:02.925 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:02.925 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:02.927 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:02.942 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:51:02.942 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:51:02.970 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:03.003 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7470, duration: 232717500
Sep 02, 2018 04:51:03.009 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7470 to make first pts zero.
Sep 02, 2018 04:51:03.020 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:51:03.021 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:03.035 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 124114944
Sep 02, 2018 04:51:03.042 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.916667 0.005008
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.916667 0.012325
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 24.000000 0.000828
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 24.083333 0.015982
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 48.000000 0.003312
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 23.976024 0.000050
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - rfps: 47.952048 0.000198
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 914705574 bytes read:2241187 seeks:3 nb_streams:3
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:03.043 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:03.045 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:03.045 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:03.045 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:03.047 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:03.049 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:03.050 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 1083 bytes read:2273955 seeks:4 frames:3
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v" for MP4 atom parsing
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 912529883 at offset 40
Sep 02, 2018 04:51:03.052 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 2175651 at offset 912529923
Sep 02, 2018 04:51:03.054 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 1204733 at offset 912530063
Sep 02, 2018 04:51:03.054 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 970167 at offset 913734796
Sep 02, 2018 04:51:03.054 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 499 at offset 914704963
Sep 02, 2018 04:51:03.054 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 1204577 at offset 912530219
Sep 02, 2018 04:51:03.054 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 1204492 at offset 912530304
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 1204428 at offset 912530368
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 912530199
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 912530207
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 969989 at offset 913734952
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 969910 at offset 913735031
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 969850 at offset 913735091
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 913734932
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 913734940
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 399 at offset 914705063
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 311 at offset 914705151
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 235 at offset 914705227
Sep 02, 2018 04:51:03.055 [0x7f4d0959b800] DEBUG - [MI]  * a28a0a48ca34ceb85455b3183537869359e15ff4 [mp4 h264/aac] Duration: 2585750ms, 1274x720 (1.769444) 23.976fps, bitrate=2829kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v")
Sep 02, 2018 04:51:03.056 [0x7f4d0959b800] DEBUG - [MI] Importing 6 media chapters.
Sep 02, 2018 04:51:03.057 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:03.059 [0x7f4d0959b800] DEBUG - Doing expensive tags write for 'S.O.S. (2)' because something changed.
Sep 02, 2018 04:51:04.343 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:04.343 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:04.346 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:04.347 [0x7f4d0959b800] DEBUG - Updating metadata item (save) (S.O.S. (2)) with ID 3419
Sep 02, 2018 04:51:04.516 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v"
Sep 02, 2018 04:51:04.516 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:04.517 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 2273955 bytes read, 4 seeks
Sep 02, 2018 04:51:04.518 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:04.519 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7118
Sep 02, 2018 04:51:04.616 [0x7f4d0959b800] DEBUG - Updating media item 7118, size=914705574, metadata_item_id=3419
Sep 02, 2018 04:51:04.617 [0x7f4d0959b800] DEBUG - Updating part with ID=7118 [/volume1/Plex/Library/Shared Videos/TV/Marvel's Agents of S.H.I.E.L.D/Season 2/ipad/Marvels.agents.of.s.h.i.e.l.d.s02e22.720p.bluray.x264-reward-22.m4v]
Sep 02, 2018 04:51:04.699 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:04.701 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:04.702 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:04.704 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:04.705 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:04.705 [0x7f4d0959b800] DEBUG - Analyzing media parts for item 3615 (Episode 23): 7324
Sep 02, 2018 04:51:04.708 [0x7f4d0959b800] DEBUG - [ID 7324] Media part analysis: /volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v
Sep 02, 2018 04:51:04.708 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3419&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:04.708 [0x7f4d0959b800] DEBUG - [MI] Opening input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v"
Sep 02, 2018 04:51:04.708 [0x7f4d0959b800] DEBUG - [FFMPEG] - Opening '/volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v' for reading
Sep 02, 2018 04:51:04.708 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Sep 02, 2018 04:51:04.739 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Sep 02, 2018 04:51:04.739 [0x7f4d0959b800] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Sep 02, 2018 04:51:04.747 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:04.759 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 7200, duration: 35503200
Sep 02, 2018 04:51:04.761 [0x7f4d0959b800] DEBUG - [FFMPEG] - Offset DTS by 7200 to make first pts zero.
Sep 02, 2018 04:51:04.762 [0x7f4d0959b800] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Sep 02, 2018 04:51:04.763 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:04.765 [0x7f4d0959b800] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 18932736
Sep 02, 2018 04:51:04.767 [0x7f4d0959b800] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Sep 02, 2018 04:51:04.767 [0x7f4d0959b800] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 139554497 bytes read:363870 seeks:3 nb_streams:3
Sep 02, 2018 04:51:04.768 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Sep 02, 2018 04:51:04.768 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Sep 02, 2018 04:51:04.770 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Sep 02, 2018 04:51:04.770 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Sep 02, 2018 04:51:04.770 [0x7f4d0959b800] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Sep 02, 2018 04:51:04.771 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:04.772 [0x7f4d0959b800] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Sep 02, 2018 04:51:04.772 [0x7f4d0959b800] DEBUG - [FFMPEG] - no picture 
Sep 02, 2018 04:51:04.773 [0x7f4d0959b800] DEBUG - [FFMPEG] - All info found
Sep 02, 2018 04:51:04.773 [0x7f4d0959b800] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 986 bytes read:396638 seeks:4 frames:3
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - [MI] Opening "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v" for MP4 atom parsing
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Skipping mdat atom of size 139256123 at offset 40
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found moov atom of size 298334 at offset 139256163
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 149212 at offset 139256303
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 148431 at offset 139405515
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found trak atom of size 439 at offset 139553946
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 149056 at offset 139256459
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 148971 at offset 139256544
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 148907 at offset 139256608
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 139256439
Sep 02, 2018 04:51:04.774 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 139256447
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 148253 at offset 139405671
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 148174 at offset 139405750
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 148114 at offset 139405810
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 139405651
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 139405659
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found mdia atom of size 339 at offset 139554046
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found minf atom of size 251 at offset 139554134
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - Mp4AtomParser: Found stbl atom of size 175 at offset 139554210
Sep 02, 2018 04:51:04.775 [0x7f4d0959b800] DEBUG - [MI]  * aec3ca0450f3b46b5da94db772fcf9bb0010277a [mp4 h264/aac] Duration: 394480ms, 720x576 (1.777778) 25.000fps, bitrate=2830kbps, audio channels=2, optimizedForStreaming=0 ("/volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v")
Sep 02, 2018 04:51:04.776 [0x7f4d0959b800] DEBUG - [MI] Importing 1 media chapters.
Sep 02, 2018 04:51:04.777 [0x7f4d0959b800] DEBUG - [MI] Chapters had generic titles, clearing.
Sep 02, 2018 04:51:04.777 [0x7f4d0959b800] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:04.777 [0x7f4d0959b800] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:04.780 [0x7f4d0959b800] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Sep 02, 2018 04:51:04.780 [0x7f4d0959b800] DEBUG - Updating metadata item (save) () with ID 3615
Sep 02, 2018 04:51:04.894 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:04.895 [0x7f4d0959b800] DEBUG - [MI] Closing input file: "/volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v"
Sep 02, 2018 04:51:04.895 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Sep 02, 2018 04:51:04.896 [0x7f4d0959b800] DEBUG - [FFMPEG] - Statistics: 396638 bytes read, 4 seeks
Sep 02, 2018 04:51:04.898 [0x7f4d0959b800] DEBUG - Committing media stream changes for part 7324
Sep 02, 2018 04:51:04.999 [0x7f4d0959b800] DEBUG - Updating media item 7324, size=139554497, metadata_item_id=3615
Sep 02, 2018 04:51:04.999 [0x7f4d0959b800] DEBUG - Updating part with ID=7324 [/volume1/Plex/Library/Shared Videos/TV/Pink Panther/4/Video Ts-23.m4v]
Sep 02, 2018 04:51:05.084 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3615&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:05.086 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3615&metadataType=4&state=-1&mediaState=analyzing
Sep 02, 2018 04:51:05.086 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3615&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:05.088 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3615&metadataType=4&state=-1&mediaState=thumbnailing
Sep 02, 2018 04:51:05.089 [0x7f4cf8bff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3615&metadataType=4&state=-1&mediaState=idle
Sep 02, 2018 04:51:05.090 [0x7f4cf8bff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=3615&metadataType=4&state=-1&mediaState=idle
