Feb 04, 2019 00:04:36.308 [0x7f0e23664700] INFO - Plex Media Scanner v1.14.1.5488-cc260c476 - ubuntu PC x86_64 - build: linux-ubuntu-x86_64 - GMT 13:00
Feb 04, 2019 00:04:36.308 [0x7f0e23664700] INFO - Linux version: 4.9.0-8-amd64 (#1 SMP Debian 4.9.130-2 (2018-10-27)), language: en-NZ
Feb 04, 2019 00:04:36.308 [0x7f0e23664700] INFO - Processor Intel(R) Core(TM) i5 CPU       M 480  @ 2.67GHz
Feb 04, 2019 00:04:36.308 [0x7f0e23664700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze --item 8338,8315,8311,8306,8313,4071,7670,7666,8423,7668 --log-file-suffix  Analysis
Feb 04, 2019 00:04:36.315 [0x7f0e2edf0d00] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Feb 04, 2019 00:04:36.504 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 8338 (Vampire Academy): 10344
Feb 04, 2019 00:04:36.504 [0x7f0e2edf0d00] DEBUG - [ID 10401] Media part analysis: /mnt/wd/4t/Plex/Movies/Vampire Academy (2014).mkv
Feb 04, 2019 00:04:36.517 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Vampire Academy (2014).mkv"
Feb 04, 2019 00:04:36.518 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Vampire Academy (2014).mkv' for reading
Feb 04, 2019 00:04:36.518 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:36.609 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:36.630 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:36.631 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:36.631 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4657 bytes read:51468 seeks:4 nb_streams:2
Feb 04, 2019 00:04:36.631 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:36.631 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:36.634 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:36.634 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:36.634 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:36.635 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:36.635 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:36.635 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:36.637 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:36.639 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.640 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:36.642 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.647 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.652 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.657 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.661 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.664 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.668 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.672 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:36.672 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 6925 bytes read:84236 seeks:4 frames:43
Feb 04, 2019 00:04:36.673 [0x7f0e2edf0d00] DEBUG - [MI]  * 7ab04bddf92a00970a6b5a2895f58ef00ed0a103 [mkv h264/aac] Duration: 6005040ms, 1920x800 (2.400000) 25.000fps, bitrate=2157kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Vampire Academy (2014).mkv")
Feb 04, 2019 00:04:36.674 [0x7f0e2edf0d00] DEBUG - [MI] Importing 18 media chapters.
Feb 04, 2019 00:04:36.674 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:36.677 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Vampire Academy (2014).mkv"
Feb 04, 2019 00:04:36.678 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 84236 bytes read, 4 seeks
Feb 04, 2019 00:04:36.679 [0x7f0e2edf0d00] DEBUG - Committing media stream changes for part 10401
Feb 04, 2019 00:04:36.738 [0x7f0e2edf0d00] DEBUG - Updating media item 10344, size=1619741002, metadata_item_id=8338
Feb 04, 2019 00:04:36.738 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10401 [/mnt/wd/4t/Plex/Movies/Vampire Academy (2014).mkv]
Feb 04, 2019 00:04:36.755 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8338&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:36.758 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8338&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:36.758 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8338&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:36.759 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8338&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:36.760 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8338&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:36.761 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8338&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:36.770 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 8315 (The Karate Kid): 10321
Feb 04, 2019 00:04:36.770 [0x7f0e2edf0d00] DEBUG - [ID 10378] Media part analysis: /mnt/wd/4t/Plex/Movies/The Karate Kid (1984).mkv
Feb 04, 2019 00:04:36.783 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/The Karate Kid (1984).mkv"
Feb 04, 2019 00:04:36.783 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/The Karate Kid (1984).mkv' for reading
Feb 04, 2019 00:04:36.783 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:36.809 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:36.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:36.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:36.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:36.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 834 bytes read:65536 seeks:2 nb_streams:3
Feb 04, 2019 00:04:36.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:36.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:36.823 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:36.823 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:36.824 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:36.824 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:36.824 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:36.827 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:36.830 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.832 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:36.834 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.841 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.845 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.847 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:36.852 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.855 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.858 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:36.860 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:36.861 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 34798 bytes read:131072 seeks:2 frames:36
Feb 04, 2019 00:04:36.861 [0x7f0e2edf0d00] DEBUG - [MI]  * 0ea2cd9cba360a0c18e5a7a494a5448393ef9719 [mkv h264/ac3] Duration: 8401454ms, 1920x800 (2.400000) 23.976fps, bitrate=6538kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/The Karate Kid (1984).mkv")
Feb 04, 2019 00:04:36.862 [0x7f0e2edf0d00] DEBUG - [MI] Importing 16 media chapters.
Feb 04, 2019 00:04:36.862 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:36.864 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/The Karate Kid (1984).mkv"
Feb 04, 2019 00:04:36.865 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 131072 bytes read, 2 seeks
Feb 04, 2019 00:04:36.866 [0x7f0e2edf0d00] DEBUG - Committing media stream changes for part 10378
Feb 04, 2019 00:04:36.892 [0x7f0e2edf0d00] DEBUG - Updating media item 10321, size=6867121699, metadata_item_id=8315
Feb 04, 2019 00:04:36.892 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10378 [/mnt/wd/4t/Plex/Movies/The Karate Kid (1984).mkv]
Feb 04, 2019 00:04:36.925 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8315&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:36.927 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8315&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:36.928 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8315&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:36.930 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8315&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:36.930 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8315&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:36.932 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8315&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:36.959 [0x7f0e2edf0d00] DEBUG - It took 10.000000 ms to retrieve 120 items.
Feb 04, 2019 00:04:36.968 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 8311 (The Green Mile): 10317
Feb 04, 2019 00:04:36.968 [0x7f0e2edf0d00] DEBUG - [ID 10374] Media part analysis: /mnt/wd/4t/Plex/Movies/The Green Mile (1999).mkv
Feb 04, 2019 00:04:36.986 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/The Green Mile (1999).mkv"
Feb 04, 2019 00:04:36.986 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/The Green Mile (1999).mkv' for reading
Feb 04, 2019 00:04:36.986 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:37.032 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:37.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:37.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:37.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:37.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 836 bytes read:65536 seeks:2 nb_streams:3
Feb 04, 2019 00:04:37.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:37.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:37.047 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:37.047 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:37.047 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:37.047 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:37.047 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:37.050 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:37.053 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.055 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:37.058 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.064 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.071 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.078 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.081 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.086 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.091 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.096 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:37.096 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 29486 bytes read:98304 seeks:2 frames:35
Feb 04, 2019 00:04:37.096 [0x7f0e2edf0d00] DEBUG - [MI]  * 07b82b335b4c1f07f07648e7aa7ed75419a7ba7d [mkv h264/ac3] Duration: 11318035ms, 1920x1080 (1.777778) 23.976fps, bitrate=6631kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/The Green Mile (1999).mkv")
Feb 04, 2019 00:04:37.097 [0x7f0e2edf0d00] DEBUG - [MI] Importing 53 media chapters.
Feb 04, 2019 00:04:37.097 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:37.102 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/The Green Mile (1999).mkv"
Feb 04, 2019 00:04:37.104 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 98304 bytes read, 2 seeks
Feb 04, 2019 00:04:37.105 [0x7f0e2edf0d00] DEBUG - Committing media stream changes for part 10374
Feb 04, 2019 00:04:37.123 [0x7f0e2edf0d00] DEBUG - Updating media item 10317, size=9381827070, metadata_item_id=8311
Feb 04, 2019 00:04:37.142 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10374 [/mnt/wd/4t/Plex/Movies/The Green Mile (1999).mkv]
Feb 04, 2019 00:04:37.192 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8311&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:37.194 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8311&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:37.195 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8311&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:37.196 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8311&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:37.197 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8311&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:37.198 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8311&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:37.214 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 8306 (The Da Vinci Code): 10312
Feb 04, 2019 00:04:37.214 [0x7f0e2edf0d00] DEBUG - [ID 10369] Media part analysis: /mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4
Feb 04, 2019 00:04:37.228 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4"
Feb 04, 2019 00:04:37.228 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4' for reading
Feb 04, 2019 00:04:37.228 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:37.243 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:37.243 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:37.263 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:37.377 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 0, duration: 109681668
Feb 04, 2019 00:04:37.388 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:37.644 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 1024, duration: 393632940
Feb 04, 2019 00:04:37.644 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Feb 04, 2019 00:04:37.666 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:37.666 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 2, edit list 0 - media time: 0, duration: 8925917
Feb 04, 2019 00:04:37.667 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5674160206 bytes read:9543486 seeks:3 nb_streams:3
Feb 04, 2019 00:04:37.667 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:37.667 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:37.667 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - demuxer injecting skip 1024 / discard 0
Feb 04, 2019 00:04:37.668 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - skip 1024 / discard 0 samples due to side data
Feb 04, 2019 00:04:37.668 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:37.668 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:37.668 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:37.673 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:37.673 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 10806 bytes read:9576254 seeks:4 frames:2
Feb 04, 2019 00:04:37.673 [0x7f0e2edf0d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:37.673 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:37.673 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 5664682224 at offset 32
Feb 04, 2019 00:04:37.673 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found moov atom of size 9477950 at offset 5664682256
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 2585595 at offset 5664682372
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 6891144 at offset 5667267967
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 639 at offset 5674159111
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2585439 at offset 5664682528
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found minf atom of size 2585354 at offset 5664682613
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2585290 at offset 5664682677
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found co64 atom of size 1713792 at offset 5665554175
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - [MI] File has co64 atom with size 1713792 at offset 5665554175
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 5664682508
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 5664682516
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 5667268103
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 5667268111
Feb 04, 2019 00:04:37.679 [0x7f0e2edf0d00] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Feb 04, 2019 00:04:37.680 [0x7f0e2edf0d00] DEBUG - [MI]  * c682ee86a1a29a15aedc8128953fc3c77c18d54a [mp4 h264/aac] Duration: 8925941ms, 1920x1080 (1.777778) 24.000fps, bitrate=5085kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4")
Feb 04, 2019 00:04:37.681 [0x7f0e2edf0d00] DEBUG - [MI] Importing 16 media chapters.
Feb 04, 2019 00:04:37.681 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:37.683 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4"
Feb 04, 2019 00:04:37.684 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 9576254 bytes read, 4 seeks
Feb 04, 2019 00:04:37.685 [0x7f0e2edf0d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:37.685 [0x7f0e2edf0d00] DEBUG - Updating media item 10312, size=5674160206, metadata_item_id=8306
Feb 04, 2019 00:04:37.685 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10369 [/mnt/wd/4t/Plex/Movies/The Da Vinci Code (2006).mp4]
Feb 04, 2019 00:04:37.708 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8306&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:37.710 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8306&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:37.711 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8306&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:37.713 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8306&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:37.714 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8306&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:37.715 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8306&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:37.727 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 8313 (The Horse Whisperer): 10319
Feb 04, 2019 00:04:37.727 [0x7f0e2edf0d00] DEBUG - [ID 10376] Media part analysis: /mnt/wd/4t/Plex/Movies/The Horse Whisperer (1998).mkv
Feb 04, 2019 00:04:37.748 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/The Horse Whisperer (1998).mkv"
Feb 04, 2019 00:04:37.748 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/The Horse Whisperer (1998).mkv' for reading
Feb 04, 2019 00:04:37.748 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:37.768 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:37.783 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:37.783 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:37.784 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:37.784 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 835 bytes read:65536 seeks:2 nb_streams:3
Feb 04, 2019 00:04:37.784 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:37.784 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:37.786 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:37.786 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:37.786 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:37.786 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:37.786 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:37.788 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:37.794 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.795 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:37.799 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.804 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.811 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.816 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.821 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.825 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:37.830 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:37.835 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:37.835 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 60070 bytes read:131072 seeks:2 frames:36
Feb 04, 2019 00:04:37.835 [0x7f0e2edf0d00] DEBUG - [MI]  * 65b655887fa58b973defdd5aea828f74b777222b [mkv h264/ac3] Duration: 10156097ms, 1920x824 (2.330097) 23.976fps, bitrate=5586kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/The Horse Whisperer (1998).mkv")
Feb 04, 2019 00:04:37.836 [0x7f0e2edf0d00] DEBUG - [MI] Importing 22 media chapters.
Feb 04, 2019 00:04:37.836 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:37.839 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/The Horse Whisperer (1998).mkv"
Feb 04, 2019 00:04:37.840 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 131072 bytes read, 2 seeks
Feb 04, 2019 00:04:37.841 [0x7f0e2edf0d00] DEBUG - Committing media stream changes for part 10376
Feb 04, 2019 00:04:37.866 [0x7f0e2edf0d00] DEBUG - Updating media item 10319, size=7091585917, metadata_item_id=8313
Feb 04, 2019 00:04:37.866 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10376 [/mnt/wd/4t/Plex/Movies/The Horse Whisperer (1998).mkv]
Feb 04, 2019 00:04:37.902 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8313&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:37.904 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8313&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:37.904 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8313&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:37.906 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8313&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:37.906 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8313&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:37.908 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8313&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:37.914 [0x7f0e2edf0d00] DEBUG - It took 10.000000 ms to retrieve 151 items.
Feb 04, 2019 00:04:37.929 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 4071 (Iron Man): 10549
Feb 04, 2019 00:04:37.929 [0x7f0e2edf0d00] DEBUG - [ID 10606] Media part analysis: /mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4
Feb 04, 2019 00:04:37.930 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4"
Feb 04, 2019 00:04:37.930 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4' for reading
Feb 04, 2019 00:04:37.930 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:37.940 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:37.940 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:37.967 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:38.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:38.046 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 181480320
Feb 04, 2019 00:04:38.057 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:38.153 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 362961936
Feb 04, 2019 00:04:38.175 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 3889497231 bytes read:3883332 seeks:1 nb_streams:2
Feb 04, 2019 00:04:38.175 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:38.175 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:38.176 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:38.176 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:38.176 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:38.176 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3424 bytes read:3916100 seeks:2 frames:3
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 3885646627 at offset 40
Feb 04, 2019 00:04:38.178 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found moov atom of size 3850564 at offset 3885646667
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 1511384 at offset 3885646783
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 2338968 at offset 3887158167
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found mdia atom of size 1511236 at offset 3885646931
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found minf atom of size 1511151 at offset 3885647016
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found stbl atom of size 1511087 at offset 3885647080
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2338832 at offset 3887158303
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found minf atom of size 2338747 at offset 3887158388
Feb 04, 2019 00:04:38.181 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2338687 at offset 3887158448
Feb 04, 2019 00:04:38.182 [0x7f0e2edf0d00] DEBUG - [MI]  * 888c95d60ad54392a3f9b7d5e809143359f24bb3 [mp4 h264/aac] Duration: 7561707ms, 1280x720 (1.777778) 23.976fps, bitrate=4114kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4")
Feb 04, 2019 00:04:38.183 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:38.183 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4"
Feb 04, 2019 00:04:38.184 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 3916100 bytes read, 2 seeks
Feb 04, 2019 00:04:38.184 [0x7f0e2edf0d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:38.184 [0x7f0e2edf0d00] DEBUG - Updating media item 10549, size=3889497231, metadata_item_id=4071
Feb 04, 2019 00:04:38.184 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10606 [/mnt/wd/4t/Plex/Movies/Marvel/Iron Man (2008).mp4]
Feb 04, 2019 00:04:38.210 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4071&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:38.211 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4071&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:38.212 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4071&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:38.213 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4071&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:38.214 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4071&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:38.215 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4071&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:38.223 [0x7f0e2edf0d00] DEBUG - It took 10.000000 ms to retrieve 149 items.
Feb 04, 2019 00:04:38.238 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 7670 (Black Panther): 10540
Feb 04, 2019 00:04:38.238 [0x7f0e2edf0d00] DEBUG - [ID 10597] Media part analysis: /mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4
Feb 04, 2019 00:04:38.240 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4"
Feb 04, 2019 00:04:38.240 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4' for reading
Feb 04, 2019 00:04:38.240 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:38.256 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:38.256 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:38.269 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:38.382 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:38.382 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 193753560
Feb 04, 2019 00:04:38.392 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:38.521 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 387508224
Feb 04, 2019 00:04:38.543 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6956600640 bytes read:5692140 seeks:1 nb_streams:2
Feb 04, 2019 00:04:38.543 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:38.543 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:38.544 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:38.545 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:38.545 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:38.545 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:38.547 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:38.547 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3459 bytes read:5724908 seeks:2 frames:3
Feb 04, 2019 00:04:38.547 [0x7f0e2edf0d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:38.547 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:38.547 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 6950941236 at offset 32
Feb 04, 2019 00:04:38.547 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found moov atom of size 5659372 at offset 6950941268
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 2387796 at offset 6950941384
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 3271364 at offset 6953329180
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2387648 at offset 6950941532
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found minf atom of size 2387563 at offset 6950941617
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2387499 at offset 6950941681
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found co64 atom of size 1548496 at offset 6951780684
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - [MI] File has co64 atom with size 1548496 at offset 6951780684
Feb 04, 2019 00:04:38.551 [0x7f0e2edf0d00] DEBUG - [MI]  * 1e7ef9288ed633065f83eca8143b940b776c9383 [mp4 h264/aac] Duration: 8073088ms, 1280x720 (1.777778) 23.976fps, bitrate=6893kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4")
Feb 04, 2019 00:04:38.552 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:38.552 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4"
Feb 04, 2019 00:04:38.553 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 5724908 bytes read, 2 seeks
Feb 04, 2019 00:04:38.553 [0x7f0e2edf0d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:38.554 [0x7f0e2edf0d00] DEBUG - Updating media item 10540, size=6956600640, metadata_item_id=7670
Feb 04, 2019 00:04:38.554 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10597 [/mnt/wd/4t/Plex/Movies/Marvel/Black Panther (2018).mp4]
Feb 04, 2019 00:04:38.578 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7670&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:38.580 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7670&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:38.581 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7670&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:38.583 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7670&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:38.583 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7670&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:38.585 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7670&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:38.593 [0x7f0e2edf0d00] DEBUG - It took 10.000000 ms to retrieve 124 items.
Feb 04, 2019 00:04:38.607 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 7666 (Thor: Ragnarok): 10562
Feb 04, 2019 00:04:38.607 [0x7f0e2edf0d00] DEBUG - [ID 10619] Media part analysis: /mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4
Feb 04, 2019 00:04:38.608 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4"
Feb 04, 2019 00:04:38.608 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4' for reading
Feb 04, 2019 00:04:38.608 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:38.611 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:38.612 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:38.622 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:38.713 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:38.713 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 187934760
Feb 04, 2019 00:04:38.723 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:38.869 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 375870480
Feb 04, 2019 00:04:38.891 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 14892574873 bytes read:5522177 seeks:1 nb_streams:2
Feb 04, 2019 00:04:38.891 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:38.891 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:38.892 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:38.893 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:38.893 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:38.893 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:38.897 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:38.898 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 6890 bytes read:5554945 seeks:2 frames:3
Feb 04, 2019 00:04:38.898 [0x7f0e2edf0d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:38.898 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:38.898 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 14887085432 at offset 32
Feb 04, 2019 00:04:38.898 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found moov atom of size 5489409 at offset 14887085464
Feb 04, 2019 00:04:38.901 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 2316105 at offset 14887085580
Feb 04, 2019 00:04:38.901 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 3173092 at offset 14889401685
Feb 04, 2019 00:04:38.901 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2315957 at offset 14887085728
Feb 04, 2019 00:04:38.901 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found minf atom of size 2315872 at offset 14887085813
Feb 04, 2019 00:04:38.901 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2315808 at offset 14887085877
Feb 04, 2019 00:04:38.901 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found co64 atom of size 1501992 at offset 14887899693
Feb 04, 2019 00:04:38.902 [0x7f0e2edf0d00] DEBUG - [MI] File has co64 atom with size 1501992 at offset 14887899693
Feb 04, 2019 00:04:38.902 [0x7f0e2edf0d00] DEBUG - [MI]  * 35095a5b0ce77c1c88ae3b3a5f6b88f89bb2d0b3 [mp4 h264/aac] Duration: 7830635ms, 1920x1080 (1.777778) 23.976fps, bitrate=15214kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4")
Feb 04, 2019 00:04:38.903 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:38.903 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4"
Feb 04, 2019 00:04:38.904 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 5554945 bytes read, 2 seeks
Feb 04, 2019 00:04:38.904 [0x7f0e2edf0d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:38.905 [0x7f0e2edf0d00] DEBUG - Updating media item 10562, size=14892574873, metadata_item_id=7666
Feb 04, 2019 00:04:38.905 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10619 [/mnt/wd/4t/Plex/Movies/Marvel/Thor Ragnarok (2017).mp4]
Feb 04, 2019 00:04:38.925 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7666&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:38.927 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7666&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:38.928 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7666&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:38.931 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7666&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:38.932 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7666&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:38.934 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7666&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:38.944 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 8423 (Crazy Rich Asians): 10429
Feb 04, 2019 00:04:38.944 [0x7f0e2edf0d00] DEBUG - [ID 10486] Media part analysis: /mnt/wd/4t/Plex/Movies/Downloads/crazy rich asians.mkv
Feb 04, 2019 00:04:38.958 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Downloads/crazy rich asians.mkv"
Feb 04, 2019 00:04:38.958 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Downloads/crazy rich asians.mkv' for reading
Feb 04, 2019 00:04:38.958 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:38.990 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:39.002 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:39.002 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:39.002 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6164 bytes read:33651 seeks:2 nb_streams:2
Feb 04, 2019 00:04:39.002 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:39.002 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:39.003 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:39.003 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:39.003 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:39.004 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:39.004 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:39.004 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:39.004 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:39.004 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:39.005 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:39.005 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:39.006 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:39.006 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:39.007 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:39.007 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:39.008 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:39.009 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:39.010 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:39.010 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:39.010 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 38898 bytes read:66419 seeks:2 frames:26
Feb 04, 2019 00:04:39.010 [0x7f0e2edf0d00] DEBUG - [MI]  * 6085cccbad1b6ea0549499b9a3bad01ae04c8115 [mkv h264/ac3] Duration: 7235353ms, 720x304 (2.368421) 23.976fps, bitrate=1579kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Downloads/crazy rich asians.mkv")
Feb 04, 2019 00:04:39.011 [0x7f0e2edf0d00] DEBUG - [MI] Importing 12 media chapters.
Feb 04, 2019 00:04:39.011 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:39.013 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Downloads/crazy rich asians.mkv"
Feb 04, 2019 00:04:39.014 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 66419 bytes read, 2 seeks
Feb 04, 2019 00:04:39.014 [0x7f0e2edf0d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:39.014 [0x7f0e2edf0d00] DEBUG - Updating media item 10429, size=1428271390, metadata_item_id=8423
Feb 04, 2019 00:04:39.015 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10486 [/mnt/wd/4t/Plex/Movies/Downloads/crazy rich asians.mkv]
Feb 04, 2019 00:04:39.057 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8423&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:39.059 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8423&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:39.059 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8423&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:39.061 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8423&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:39.062 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8423&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:39.063 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8423&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:39.086 [0x7f0e2edf0d00] DEBUG - It took 10.000000 ms to retrieve 113 items.
Feb 04, 2019 00:04:39.100 [0x7f0e2edf0d00] DEBUG - Analyzing media parts for item 7668 (Justice League): 10552
Feb 04, 2019 00:04:39.101 [0x7f0e2edf0d00] DEBUG - [ID 10609] Media part analysis: /mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4
Feb 04, 2019 00:04:39.130 [0x7f0e2edf0d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4"
Feb 04, 2019 00:04:39.131 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4' for reading
Feb 04, 2019 00:04:39.131 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:39.134 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:39.134 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:39.174 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:39.296 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:39.296 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 172862712
Feb 04, 2019 00:04:39.305 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:39.430 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 345727008
Feb 04, 2019 00:04:39.451 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 13662648014 bytes read:5082065 seeks:1 nb_streams:2
Feb 04, 2019 00:04:39.451 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:39.451 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:39.453 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:39.453 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:39.453 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:39.453 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:39.458 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:39.458 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 6890 bytes read:5114833 seeks:2 frames:3
Feb 04, 2019 00:04:39.458 [0x7f0e2edf0d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:39.458 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:39.458 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 13657598685 at offset 32
Feb 04, 2019 00:04:39.458 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found moov atom of size 5049297 at offset 13657598717
Feb 04, 2019 00:04:39.461 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 2130401 at offset 13657598833
Feb 04, 2019 00:04:39.461 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found trak atom of size 2918684 at offset 13659729234
Feb 04, 2019 00:04:39.462 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2130253 at offset 13657598981
Feb 04, 2019 00:04:39.462 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found minf atom of size 2130168 at offset 13657599066
Feb 04, 2019 00:04:39.462 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2130104 at offset 13657599130
Feb 04, 2019 00:04:39.462 [0x7f0e2edf0d00] DEBUG - Mp4AtomParser: Found co64 atom of size 1381536 at offset 13658347698
Feb 04, 2019 00:04:39.462 [0x7f0e2edf0d00] DEBUG - [MI] File has co64 atom with size 1381536 at offset 13658347698
Feb 04, 2019 00:04:39.462 [0x7f0e2edf0d00] DEBUG - [MI]  * eceb0dba6f332cf8e6bceeb341b59397fa8f17c0 [mp4 h264/aac] Duration: 7202646ms, 1920x1080 (1.777778) 23.976fps, bitrate=15175kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4")
Feb 04, 2019 00:04:39.463 [0x7f0e2edf0d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:39.463 [0x7f0e2edf0d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4"
Feb 04, 2019 00:04:39.464 [0x7f0e2edf0d00] DEBUG - [FFMPEG] - Statistics: 5114833 bytes read, 2 seeks
Feb 04, 2019 00:04:39.464 [0x7f0e2edf0d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:39.465 [0x7f0e2edf0d00] DEBUG - Updating media item 10552, size=13662648014, metadata_item_id=7668
Feb 04, 2019 00:04:39.465 [0x7f0e2edf0d00] DEBUG - Updating part with ID=10609 [/mnt/wd/4t/Plex/Movies/Marvel/Justice_League (2017).mp4]
Feb 04, 2019 00:04:39.486 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7668&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:39.488 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7668&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:39.489 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7668&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:39.490 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7668&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:39.491 [0x7f0e1e3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7668&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:39.492 [0x7f0e1e3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=7668&metadataType=1&state=-1&mediaState=idle
