Jan 08, 2019 04:08:20.272 [0x7f79fb2d6700] INFO - Plex Media Scanner v1.14.1.5488-cc260c476 - ubuntu PC x86_64 - build: linux-ubuntu-x86_64 - GMT -07:00
Jan 08, 2019 04:08:20.272 [0x7f79fb2d6700] INFO - Linux version: 3.10.0-957.1.3.el7.x86_64 (#1 SMP Thu Nov 29 14:49:43 UTC 2018), language: en-US
Jan 08, 2019 04:08:20.272 [0x7f79fb2d6700] INFO - Processor Intel(R) Xeon(R) CPU           E5645  @ 2.40GHz
Jan 08, 2019 04:08:20.272 [0x7f79fb2d6700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze --item 9755,7843,9189,9190,9750,9159,9168,8698,9212,9761 --log-file-suffix  Analysis
Jan 08, 2019 04:08:20.281 [0x7f7a0cfa7840] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Jan 08, 2019 04:08:20.482 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9755 (George): 21832
Jan 08, 2019 04:08:20.484 [0x7f7a0cfa7840] DEBUG - [ID 29136] Media part analysis: /mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x22 - George.mkv
Jan 08, 2019 04:08:20.484 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x22 - George.mkv"
Jan 08, 2019 04:08:20.485 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x22 - George.mkv' for reading
Jan 08, 2019 04:08:20.485 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:20.524 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Jan 08, 2019 04:08:20.547 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:20.548 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:20.548 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:20.548 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:20.548 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7037 bytes read:45931 seeks:2 nb_streams:4
Jan 08, 2019 04:08:20.549 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:20.549 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:20.549 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - palette:
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x0d0d0d
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - 
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - palette:
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.550 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:20.551 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x0d0d0d
Jan 08, 2019 04:08:20.551 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:20.551 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - 
Jan 08, 2019 04:08:20.551 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:20.551 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:20.552 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:20.552 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:20.552 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:20.553 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:20.555 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:20.555 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:20.556 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:20.557 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:20.559 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:20.560 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:20.561 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:20.562 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:20.563 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:20.564 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:20.565 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 9221 bytes read:78699 seeks:2 frames:34
Jan 08, 2019 04:08:20.566 [0x7f7a0cfa7840] DEBUG - [MI]  * 5f05fbe0e2fb578d0732349373d48b24615e339e [mkv h264/aac] Duration: 1560064ms, 640x480 (1.333333) 23.976fps, bitrate=942kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x22 - George.mkv")
Jan 08, 2019 04:08:20.567 [0x7f7a0cfa7840] DEBUG - [MI] Importing 11 media chapters.
Jan 08, 2019 04:08:20.567 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:20.570 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x22 - George.mkv"
Jan 08, 2019 04:08:20.571 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 78699 bytes read, 2 seeks
Jan 08, 2019 04:08:20.573 [0x7f7a0cfa7840] DEBUG - Committing media stream changes for part 29136
Jan 08, 2019 04:08:20.576 [0x7f7a0cfa7840] DEBUG - Updating media item 21832, size=183852763, metadata_item_id=9755
Jan 08, 2019 04:08:20.576 [0x7f7a0cfa7840] DEBUG - Updating part with ID=29136 [/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x22 - George.mkv]
Jan 08, 2019 04:08:20.578 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9755&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:20.582 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9755&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:20.582 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9755&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:20.584 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9755&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:20.585 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9755&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:20.586 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9755&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:20.602 [0x7f7a0cfa7840] DEBUG - It took 10.000000 ms to retrieve 151 items.
Jan 08, 2019 04:08:20.610 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 7843 (The Empire Strikes Back): 7050,13989
Jan 08, 2019 04:08:20.610 [0x7f7a0cfa7840] DEBUG - [ID 20274] Media part analysis: /mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Despecialized Edition v2.0.mkv
Jan 08, 2019 04:08:20.611 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Despecialized Edition v2.0.mkv"
Jan 08, 2019 04:08:20.611 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Despecialized Edition v2.0.mkv' for reading
Jan 08, 2019 04:08:20.611 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:21.097 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Jan 08, 2019 04:08:21.098 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.098 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.098 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.098 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.098 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:4 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.098 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:5 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:6 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:7 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:8 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:9 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:10 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:11 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:12 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:13 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:14 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:15 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.099 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:16 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:17 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:18 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:19 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:20 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:21 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:22 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10781 bytes read:32768 seeks:0 nb_streams:23
Jan 08, 2019 04:08:21.100 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:21.101 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:21.110 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:21.111 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:21.111 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:21.112 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:21.122 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.122 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.122 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.122 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.122 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.124 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:21.126 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.126 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.126 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.126 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.126 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.131 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.131 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.131 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.131 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.131 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.134 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.134 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.134 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.134 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.134 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.140 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.140 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.140 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.140 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.140 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:21.142 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.142 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.142 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.142 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.142 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Jan 08, 2019 04:08:21.144 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.144 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.144 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.144 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.144 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.146 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:21.146 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.146 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.146 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.146 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:21.151 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:21.151 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 427914 bytes read:458752 seeks:0 frames:458
Jan 08, 2019 04:08:21.152 [0x7f7a0cfa7840] DEBUG - [MI]  * ae7980ce9e2196d7cf72f3f93cc866019253f28c [mkv h264/dca] Duration: 7586120ms, 1280x720 (1.777778) 23.976fps, bitrate=22320kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Despecialized Edition v2.0.mkv")
Jan 08, 2019 04:08:21.153 [0x7f7a0cfa7840] DEBUG - [MI] Importing 50 media chapters.
Jan 08, 2019 04:08:21.153 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:21.161 [0x7f7a0cfa7840] DEBUG - Doing expensive tags write for 'The Empire Strikes Back' because something changed.
Jan 08, 2019 04:08:21.190 [0x7f7a0cfa7840] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:21.190 [0x7f7a0cfa7840] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:21.193 [0x7f7a0cfa7840] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:21.193 [0x7f7a0cfa7840] DEBUG - Updating metadata item (save) (The Empire Strikes Back) with ID 7843
Jan 08, 2019 04:08:21.197 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Despecialized Edition v2.0.mkv"
Jan 08, 2019 04:08:21.200 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 458752 bytes read, 0 seeks
Jan 08, 2019 04:08:21.206 [0x7f7a0cfa7840] DEBUG - Updating media item 7050, size=21165363450, metadata_item_id=7843
Jan 08, 2019 04:08:21.207 [0x7f7a0cfa7840] DEBUG - Updating part with ID=20274 [/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Despecialized Edition v2.0.mkv]
Jan 08, 2019 04:08:21.208 [0x7f7a0cfa7840] DEBUG - [ID 21017] Media part analysis: /mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Special Edition.mkv
Jan 08, 2019 04:08:21.209 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:21.209 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Special Edition.mkv"
Jan 08, 2019 04:08:21.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Special Edition.mkv' for reading
Jan 08, 2019 04:08:21.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:21.211 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:21.211 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:21.213 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:21.213 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=idle
Jan 08, 2019 04:08:21.215 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=idle
Jan 08, 2019 04:08:22.907 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Jan 08, 2019 04:08:22.910 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:22.910 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:22.910 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:22.911 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 828 bytes read:65536 seeks:2 nb_streams:3
Jan 08, 2019 04:08:22.911 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:22.911 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:22.913 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:22.913 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:22.913 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:22.913 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:22.913 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:22.914 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:22.915 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:22.916 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:22.916 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:22.918 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:22.919 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:22.920 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:22.921 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:22.921 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:22.922 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:22.923 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:22.924 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 25219 bytes read:98304 seeks:2 frames:28
Jan 08, 2019 04:08:22.924 [0x7f7a0cfa7840] DEBUG - [MI]  * 1b3d311ae48e6032408bec402a973183929b8cef [mkv h264/ac3] Duration: 7642433ms, 720x364 (2.343389) 23.976fps, bitrate=1988kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Special Edition.mkv")
Jan 08, 2019 04:08:22.925 [0x7f7a0cfa7840] DEBUG - [MI] Importing 50 media chapters.
Jan 08, 2019 04:08:22.925 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:22.933 [0x7f7a0cfa7840] DEBUG - Doing expensive tags write for 'The Empire Strikes Back' because something changed.
Jan 08, 2019 04:08:22.960 [0x7f7a0cfa7840] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:22.960 [0x7f7a0cfa7840] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:22.964 [0x7f7a0cfa7840] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:22.964 [0x7f7a0cfa7840] DEBUG - Updating metadata item (save) (The Empire Strikes Back) with ID 7843
Jan 08, 2019 04:08:22.966 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Special Edition.mkv"
Jan 08, 2019 04:08:22.967 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 98304 bytes read, 2 seeks
Jan 08, 2019 04:08:22.969 [0x7f7a0cfa7840] DEBUG - Updating media item 13989, size=1899863091, metadata_item_id=7843
Jan 08, 2019 04:08:22.970 [0x7f7a0cfa7840] DEBUG - Updating part with ID=21017 [/mnt/nfs/media/Videos/Movies/Star Wars The Empire Strikes Back (1980)/Star Wars The Empire Strikes Back (1980) Special Edition.mkv]
Jan 08, 2019 04:08:22.971 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:22.973 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:22.974 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:22.975 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:22.976 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=idle
Jan 08, 2019 04:08:22.977 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9189 (In Concert): 18667
Jan 08, 2019 04:08:22.977 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=7843&metadataType=1&state=-1&mediaState=idle
Jan 08, 2019 04:08:22.978 [0x7f7a0cfa7840] DEBUG - [ID 25799] Media part analysis: /mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4
Jan 08, 2019 04:08:22.978 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4"
Jan 08, 2019 04:08:22.978 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4' for reading
Jan 08, 2019 04:08:22.978 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:23.430 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Jan 08, 2019 04:08:23.431 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Jan 08, 2019 04:08:23.444 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:23.927 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 6006, duration: 134945811
Jan 08, 2019 04:08:23.931 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Offset DTS by 6006 to make first pts zero.
Jan 08, 2019 04:08:23.941 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Jan 08, 2019 04:08:23.941 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:23.946 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:23.949 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:23.950 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 3, edit list 0 - media time: 6006, duration: 134846712
Jan 08, 2019 04:08:23.950 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Jan 08, 2019 04:08:24.046 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 310197375 bytes read:1241159 seeks:7 nb_streams:4
Jan 08, 2019 04:08:24.047 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:24.047 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:24.048 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:24.048 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:24.048 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:24.049 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:24.050 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:24.051 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4963 bytes read:1273927 seeks:8 frames:13
Jan 08, 2019 04:08:24.051 [0x7f7a0cfa7840] DEBUG - [MI] Opening "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4" for MP4 atom parsing
Jan 08, 2019 04:08:24.051 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Jan 08, 2019 04:08:24.051 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping free atom of size 132 at offset 28
Jan 08, 2019 04:08:24.051 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping mdat atom of size 309090411 at offset 160
Jan 08, 2019 04:08:24.051 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found moov atom of size 1106780 at offset 309090571
Jan 08, 2019 04:08:24.052 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 668631 at offset 309090711
Jan 08, 2019 04:08:24.052 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 361938 at offset 309759342
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 75404 at offset 310121280
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 556 at offset 310196684
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 668475 at offset 309090811
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 668402 at offset 309090884
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 668338 at offset 309090948
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found co64 atom of size 89896 at offset 309270981
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - [MI] File has co64 atom with size 89896 at offset 309270981
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 309759286
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 309759294
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - [MI] Determined stream id 4 has chapters, not subtitles
Jan 08, 2019 04:08:24.053 [0x7f7a0cfa7840] DEBUG - [MI]  * 65d8f74ba8a50fa6d2187e4815e2bb0889c5e671 [mp4 h264/aac] Duration: 1499435ms, 710x478 (1.320316) 29.970fps, bitrate=1655kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4")
Jan 08, 2019 04:08:24.055 [0x7f7a0cfa7840] DEBUG - [MI] Importing 4 media chapters.
Jan 08, 2019 04:08:24.055 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:24.056 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4"
Jan 08, 2019 04:08:24.058 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 1273927 bytes read, 8 seeks
Jan 08, 2019 04:08:24.059 [0x7f7a0cfa7840] DEBUG - Updating media item 18667, size=310197483, metadata_item_id=9189
Jan 08, 2019 04:08:24.060 [0x7f7a0cfa7840] DEBUG - Updating part with ID=25799 [/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E19 - In Concert.mp4]
Jan 08, 2019 04:08:24.062 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9189&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:24.064 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9189&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:24.064 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9189&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:24.066 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9189&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:24.066 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9189&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:24.066 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9190 (The Doctor's Daughter): 18668
Jan 08, 2019 04:08:24.068 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9189&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:24.068 [0x7f7a0cfa7840] DEBUG - [ID 25800] Media part analysis: /mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4
Jan 08, 2019 04:08:24.068 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4"
Jan 08, 2019 04:08:24.068 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4' for reading
Jan 08, 2019 04:08:24.068 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:24.562 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Jan 08, 2019 04:08:24.562 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Jan 08, 2019 04:08:24.578 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:24.627 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 6006, duration: 133032900
Jan 08, 2019 04:08:24.631 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Offset DTS by 6006 to make first pts zero.
Jan 08, 2019 04:08:24.641 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Jan 08, 2019 04:08:24.641 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:24.647 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:24.650 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:24.650 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 3, edit list 0 - media time: 6006, duration: 133032900
Jan 08, 2019 04:08:24.650 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Jan 08, 2019 04:08:24.679 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 303925709 bytes read:1265154 seeks:8 nb_streams:4
Jan 08, 2019 04:08:24.679 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:24.679 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:24.681 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:24.681 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:24.681 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:24.682 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:24.686 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:25.146 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 17081 bytes read:1297922 seeks:9 frames:13
Jan 08, 2019 04:08:25.146 [0x7f7a0cfa7840] DEBUG - [MI] Opening "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4" for MP4 atom parsing
Jan 08, 2019 04:08:25.147 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Jan 08, 2019 04:08:25.147 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping free atom of size 132 at offset 28
Jan 08, 2019 04:08:25.147 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping mdat atom of size 302835747 at offset 160
Jan 08, 2019 04:08:25.147 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found moov atom of size 1089778 at offset 302835907
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 657853 at offset 302836047
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 356770 at offset 303493900
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 74332 at offset 303850670
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 572 at offset 303925002
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 657697 at offset 302836147
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 657624 at offset 302836220
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 657560 at offset 302836284
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found co64 atom of size 88616 at offset 303013756
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - [MI] File has co64 atom with size 88616 at offset 303013756
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 303493844
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 303493852
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - [MI] Determined stream id 4 has chapters, not subtitles
Jan 08, 2019 04:08:25.148 [0x7f7a0cfa7840] DEBUG - [MI]  * 1febaf2bea4e1d522b8cd4d14fe05673d4260360 [mp4 h264/aac] Duration: 1478143ms, 704x480 (1.303704) 29.970fps, bitrate=1644kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4")
Jan 08, 2019 04:08:25.150 [0x7f7a0cfa7840] DEBUG - [MI] Importing 5 media chapters.
Jan 08, 2019 04:08:25.150 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:25.152 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4"
Jan 08, 2019 04:08:25.154 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 1297922 bytes read, 9 seeks
Jan 08, 2019 04:08:25.156 [0x7f7a0cfa7840] DEBUG - Updating media item 18668, size=303925817, metadata_item_id=9190
Jan 08, 2019 04:08:25.157 [0x7f7a0cfa7840] DEBUG - Updating part with ID=25800 [/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 02/WKRP in Cincinnati - S02E20 - The Doctor's Daughter.mp4]
Jan 08, 2019 04:08:25.159 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9190&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:25.161 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9190&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:25.161 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9190&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:25.163 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9190&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:25.163 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9190&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:25.164 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9750 (For Want of a Boot): 21827
Jan 08, 2019 04:08:25.165 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9190&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:25.165 [0x7f7a0cfa7840] DEBUG - [ID 29131] Media part analysis: /mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x17 - For Want of a Boot.mkv
Jan 08, 2019 04:08:25.165 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x17 - For Want of a Boot.mkv"
Jan 08, 2019 04:08:25.166 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x17 - For Want of a Boot.mkv' for reading
Jan 08, 2019 04:08:25.166 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:25.192 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Jan 08, 2019 04:08:25.206 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:25.206 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7037 bytes read:45947 seeks:2 nb_streams:4
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - palette:
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.207 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x0d0d0d
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - 
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - palette:
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x0d0d0d
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:25.208 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - 
Jan 08, 2019 04:08:25.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:25.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:25.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:25.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:25.209 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:25.210 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:25.210 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:25.211 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:25.211 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:25.213 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:25.214 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:25.215 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:25.215 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:25.217 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:25.217 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:25.218 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:25.219 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 8286 bytes read:78715 seeks:2 frames:34
Jan 08, 2019 04:08:25.219 [0x7f7a0cfa7840] DEBUG - [MI]  * 68b10914396fbe86d44cd3e2b8c37a72285bca4c [mkv h264/aac] Duration: 1561102ms, 640x480 (1.333333) 23.976fps, bitrate=942kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x17 - For Want of a Boot.mkv")
Jan 08, 2019 04:08:25.220 [0x7f7a0cfa7840] DEBUG - [MI] Importing 11 media chapters.
Jan 08, 2019 04:08:25.220 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:25.223 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x17 - For Want of a Boot.mkv"
Jan 08, 2019 04:08:25.224 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 78715 bytes read, 2 seeks
Jan 08, 2019 04:08:25.226 [0x7f7a0cfa7840] DEBUG - Committing media stream changes for part 29131
Jan 08, 2019 04:08:25.228 [0x7f7a0cfa7840] DEBUG - Updating media item 21827, size=183846542, metadata_item_id=9750
Jan 08, 2019 04:08:25.228 [0x7f7a0cfa7840] DEBUG - Updating part with ID=29131 [/mnt/nfs/media/Videos/TV Shows/MASH/Season 2/2x17 - For Want of a Boot.mkv]
Jan 08, 2019 04:08:25.230 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9750&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:25.232 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9750&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:25.232 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9750&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:25.234 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9750&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:25.234 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9159 (Frog Story): 18638
Jan 08, 2019 04:08:25.234 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9750&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:25.236 [0x7f7a0cfa7840] DEBUG - [ID 25770] Media part analysis: /mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4
Jan 08, 2019 04:08:25.236 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9750&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:25.236 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4"
Jan 08, 2019 04:08:25.236 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4' for reading
Jan 08, 2019 04:08:25.236 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:25.272 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Jan 08, 2019 04:08:25.273 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Jan 08, 2019 04:08:25.279 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:25.315 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 6006, duration: 134837703
Jan 08, 2019 04:08:25.320 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Offset DTS by 6006 to make first pts zero.
Jan 08, 2019 04:08:25.329 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Jan 08, 2019 04:08:25.329 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:25.334 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:25.335 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 2, edit list 0 - media time: 6006, duration: 134750616
Jan 08, 2019 04:08:25.335 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Jan 08, 2019 04:08:25.374 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 332256117 bytes read:1059632 seeks:7 nb_streams:3
Jan 08, 2019 04:08:25.374 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:25.374 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:25.375 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:25.375 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:25.375 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:25.375 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:25.376 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:25.376 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3436 bytes read:1092400 seeks:8 frames:8
Jan 08, 2019 04:08:25.376 [0x7f7a0cfa7840] DEBUG - [MI] Opening "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4" for MP4 atom parsing
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping free atom of size 132 at offset 28
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping mdat atom of size 331326876 at offset 160
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found moov atom of size 929057 at offset 331327036
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 606752 at offset 331327176
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 321514 at offset 331933928
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 540 at offset 332255442
Jan 08, 2019 04:08:25.377 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 606596 at offset 331327276
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 606523 at offset 331327349
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 606459 at offset 331327413
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 331933872
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 331933880
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 321392 at offset 331934028
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 321319 at offset 331934101
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 321259 at offset 331934161
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 404 at offset 332255542
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 331 at offset 332255615
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 211 at offset 332255735
Jan 08, 2019 04:08:25.378 [0x7f7a0cfa7840] DEBUG - [MI]  * 1ff390f25f3d020a26c6d8b2b27df1172883afef [mp4 h264/aac] Duration: 1498219ms, 700x478 (1.301720) 29.970fps, bitrate=1774kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4")
Jan 08, 2019 04:08:25.379 [0x7f7a0cfa7840] DEBUG - [MI] Importing 4 media chapters.
Jan 08, 2019 04:08:25.379 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:25.381 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4"
Jan 08, 2019 04:08:25.381 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 1092400 bytes read, 8 seeks
Jan 08, 2019 04:08:25.383 [0x7f7a0cfa7840] DEBUG - Updating media item 18638, size=332256225, metadata_item_id=9159
Jan 08, 2019 04:08:25.384 [0x7f7a0cfa7840] DEBUG - Updating part with ID=25770 [/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E11 - Frog Story.mp4]
Jan 08, 2019 04:08:25.385 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9159&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:25.387 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9159&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:25.388 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9159&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:25.389 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9159&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:25.390 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9168 (Nothing to Fear But...): 18647
Jan 08, 2019 04:08:25.390 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9159&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:25.391 [0x7f7a0cfa7840] DEBUG - [ID 25779] Media part analysis: /mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4
Jan 08, 2019 04:08:25.391 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4"
Jan 08, 2019 04:08:25.391 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4' for reading
Jan 08, 2019 04:08:25.391 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:25.391 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9159&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:25.880 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Jan 08, 2019 04:08:25.881 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Jan 08, 2019 04:08:25.889 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:26.375 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 6006, duration: 134774640
Jan 08, 2019 04:08:26.379 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Offset DTS by 6006 to make first pts zero.
Jan 08, 2019 04:08:26.389 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Jan 08, 2019 04:08:26.389 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:26.394 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:26.394 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 2, edit list 0 - media time: 6006, duration: 134711577
Jan 08, 2019 04:08:26.394 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Jan 08, 2019 04:08:26.446 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 281348280 bytes read:1059384 seeks:7 nb_streams:3
Jan 08, 2019 04:08:26.446 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:26.446 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:26.447 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:26.447 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:26.447 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:26.447 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:26.448 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:26.448 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3571 bytes read:1092152 seeks:8 frames:8
Jan 08, 2019 04:08:26.448 [0x7f7a0cfa7840] DEBUG - [MI] Opening "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4" for MP4 atom parsing
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping free atom of size 132 at offset 28
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping mdat atom of size 280412152 at offset 160
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found moov atom of size 935944 at offset 280412312
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 613803 at offset 280412452
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 321350 at offset 281026255
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 540 at offset 281347605
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 613647 at offset 280412552
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 613574 at offset 280412625
Jan 08, 2019 04:08:26.449 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 613510 at offset 280412689
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 281026199
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 281026207
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 321228 at offset 281026355
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 321155 at offset 281026428
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 321095 at offset 281026488
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 404 at offset 281347705
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 331 at offset 281347778
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 211 at offset 281347898
Jan 08, 2019 04:08:26.450 [0x7f7a0cfa7840] DEBUG - [MI]  * 4de93225acb89c3ace95654588b7f7131d07d940 [mp4 h264/aac] Duration: 1497515ms, 702x478 (1.305439) 29.970fps, bitrate=1503kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4")
Jan 08, 2019 04:08:26.451 [0x7f7a0cfa7840] DEBUG - [MI] Importing 4 media chapters.
Jan 08, 2019 04:08:26.451 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:26.453 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4"
Jan 08, 2019 04:08:26.453 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 1092152 bytes read, 8 seeks
Jan 08, 2019 04:08:26.456 [0x7f7a0cfa7840] DEBUG - Updating media item 18647, size=281348388, metadata_item_id=9168
Jan 08, 2019 04:08:26.456 [0x7f7a0cfa7840] DEBUG - Updating part with ID=25779 [/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 03/WKRP in Cincinnati - S03E20 - Till Debt Do Us Part.mp4]
Jan 08, 2019 04:08:26.458 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9168&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:26.460 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9168&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:26.460 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9168&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:26.462 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9168&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:26.462 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9168&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:26.464 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9168&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:26.470 [0x7f7a0cfa7840] DEBUG - It took 10.000000 ms to retrieve 108 items.
Jan 08, 2019 04:08:26.476 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 8698 (The Hobbit: The Desolation of Smaug): 10198
Jan 08, 2019 04:08:26.476 [0x7f7a0cfa7840] DEBUG - [ID 17215] Media part analysis: /mnt/nfs/media/Videos/Movies/The Hobbit The Desolation Of Smaug (2013).mkv
Jan 08, 2019 04:08:26.476 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/Movies/The Hobbit The Desolation Of Smaug (2013).mkv"
Jan 08, 2019 04:08:26.476 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/Movies/The Hobbit The Desolation Of Smaug (2013).mkv' for reading
Jan 08, 2019 04:08:26.476 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:26.502 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Jan 08, 2019 04:08:26.516 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:26.516 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:26.517 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 769 bytes read:65536 seeks:2 nb_streams:2
Jan 08, 2019 04:08:26.517 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:26.517 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:26.517 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:26.517 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:26.518 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:26.518 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:26.518 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:26.521 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:26.523 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:26.525 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:26.527 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:26.532 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:26.537 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:26.543 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:26.545 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:26.549 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:26.552 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:26.556 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:27.007 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 62215 bytes read:131072 seeks:2 frames:38
Jan 08, 2019 04:08:27.007 [0x7f7a0cfa7840] DEBUG - [MI]  * 925f1209c0a1ccb40d1439af4092bff6a0d0480a [mkv h264/dca] Duration: 9677963ms, 1918x800 (2.397500) 23.976fps, bitrate=11785kbps, audio channels=8, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/Movies/The Hobbit The Desolation Of Smaug (2013).mkv")
Jan 08, 2019 04:08:27.009 [0x7f7a0cfa7840] DEBUG - [MI] Importing 45 media chapters.
Jan 08, 2019 04:08:27.009 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:27.015 [0x7f7a0cfa7840] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:27.015 [0x7f7a0cfa7840] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:27.019 [0x7f7a0cfa7840] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:27.020 [0x7f7a0cfa7840] DEBUG - Updating metadata item (save) (The Hobbit: The Desolation of Smaug) with ID 8698
Jan 08, 2019 04:08:27.031 [0x7f7a0cfa7840] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:27.032 [0x7f7a0cfa7840] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:27.035 [0x7f7a0cfa7840] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Jan 08, 2019 04:08:27.035 [0x7f7a0cfa7840] DEBUG - Updating metadata item (save) (The Hobbit: The Desolation of Smaug) with ID 8698
Jan 08, 2019 04:08:27.038 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/Movies/The Hobbit The Desolation Of Smaug (2013).mkv"
Jan 08, 2019 04:08:27.042 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 131072 bytes read, 2 seeks
Jan 08, 2019 04:08:27.044 [0x7f7a0cfa7840] DEBUG - Updating media item 10198, size=14258022688, metadata_item_id=8698
Jan 08, 2019 04:08:27.044 [0x7f7a0cfa7840] DEBUG - Updating part with ID=17215 [/mnt/nfs/media/Videos/Movies/The Hobbit The Desolation Of Smaug (2013).mkv]
Jan 08, 2019 04:08:27.046 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=8698&metadataType=1&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:27.048 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=8698&metadataType=1&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:27.049 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=8698&metadataType=1&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:27.051 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=8698&metadataType=1&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:27.051 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9212 (A Commercial Break): 18689
Jan 08, 2019 04:08:27.051 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=8698&metadataType=1&state=-1&mediaState=idle
Jan 08, 2019 04:08:27.053 [0x7f7a0cfa7840] DEBUG - [ID 25821] Media part analysis: /mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4
Jan 08, 2019 04:08:27.053 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4"
Jan 08, 2019 04:08:27.053 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4' for reading
Jan 08, 2019 04:08:27.053 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:27.053 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=8698&metadataType=1&state=-1&mediaState=idle
Jan 08, 2019 04:08:27.084 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Jan 08, 2019 04:08:27.084 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - ISO: File Type Major Brand: mp42
Jan 08, 2019 04:08:27.117 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:27.601 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 6006, duration: 133831698
Jan 08, 2019 04:08:27.605 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Offset DTS by 6006 to make first pts zero.
Jan 08, 2019 04:08:27.615 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Jan 08, 2019 04:08:27.615 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:27.620 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:27.623 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Jan 08, 2019 04:08:27.623 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Processing st: 3, edit list 0 - media time: 6006, duration: 133831698
Jan 08, 2019 04:08:27.623 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Jan 08, 2019 04:08:27.706 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 363103246 bytes read:1268791 seeks:8 nb_streams:4
Jan 08, 2019 04:08:27.706 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:27.706 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:27.707 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:27.707 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:27.707 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:27.708 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:27.708 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:27.709 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4963 bytes read:1301559 seeks:9 frames:13
Jan 08, 2019 04:08:27.709 [0x7f7a0cfa7840] DEBUG - [MI] Opening "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4" for MP4 atom parsing
Jan 08, 2019 04:08:27.709 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 28 at offset 0
Jan 08, 2019 04:08:27.709 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping free atom of size 132 at offset 28
Jan 08, 2019 04:08:27.709 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Skipping mdat atom of size 362005989 at offset 160
Jan 08, 2019 04:08:27.709 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found moov atom of size 1097073 at offset 362006149
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 662576 at offset 362006289
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 358914 at offset 362668865
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 74760 at offset 363027779
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found trak atom of size 572 at offset 363102539
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found mdia atom of size 662420 at offset 362006389
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found minf atom of size 662347 at offset 362006462
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found stbl atom of size 662283 at offset 362006526
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found co64 atom of size 89152 at offset 362185075
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - [MI] File has co64 atom with size 89152 at offset 362185075
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 362668809
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 362668817
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - [MI] Determined stream id 4 has chapters, not subtitles
Jan 08, 2019 04:08:27.710 [0x7f7a0cfa7840] DEBUG - [MI]  * eaf9f8b72b8cdf0e299ec77206d210a95945e37b [mp4 h264/aac] Duration: 1487019ms, 710x480 (1.314815) 29.970fps, bitrate=1953kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4")
Jan 08, 2019 04:08:27.711 [0x7f7a0cfa7840] DEBUG - [MI] Importing 5 media chapters.
Jan 08, 2019 04:08:27.711 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:27.713 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4"
Jan 08, 2019 04:08:27.714 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 1301559 bytes read, 9 seeks
Jan 08, 2019 04:08:27.717 [0x7f7a0cfa7840] DEBUG - Updating media item 18689, size=363103354, metadata_item_id=9212
Jan 08, 2019 04:08:27.717 [0x7f7a0cfa7840] DEBUG - Updating part with ID=25821 [/mnt/nfs/media/Videos/TV Shows/WKRP in Cincinnati/Season 01/WKRP In Cincinnati - S01E17 - A Commercial Break.mp4]
Jan 08, 2019 04:08:27.719 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9212&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:27.721 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9212&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:27.721 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9212&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:27.723 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9212&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:27.724 [0x7f7a0cfa7840] DEBUG - Analyzing media parts for item 9761 (Officer of the Day): 21837
Jan 08, 2019 04:08:27.724 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9212&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:27.725 [0x7f7a0cfa7840] DEBUG - [ID 29141] Media part analysis: /mnt/nfs/media/Videos/TV Shows/MASH/Season 3/3x03 - Officer of the Day.mkv
Jan 08, 2019 04:08:27.725 [0x7f7a0cfa7840] DEBUG - [MI] Opening input file: "/mnt/nfs/media/Videos/TV Shows/MASH/Season 3/3x03 - Officer of the Day.mkv"
Jan 08, 2019 04:08:27.725 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Opening '/mnt/nfs/media/Videos/TV Shows/MASH/Season 3/3x03 - Officer of the Day.mkv' for reading
Jan 08, 2019 04:08:27.726 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Jan 08, 2019 04:08:27.726 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9212&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:27.747 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Jan 08, 2019 04:08:27.754 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:27.754 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:27.754 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:27.754 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Jan 08, 2019 04:08:27.754 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 7038 bytes read:46001 seeks:2 nb_streams:4
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - palette:
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.755 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x0d0d0d
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - 
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - palette:
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.756 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0xcbcbcb
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x0d0d0d
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] -  0x000000
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - 
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Jan 08, 2019 04:08:27.757 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Jan 08, 2019 04:08:27.758 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Jan 08, 2019 04:08:27.758 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Jan 08, 2019 04:08:27.758 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Jan 08, 2019 04:08:27.759 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:27.760 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:27.760 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - no picture 
Jan 08, 2019 04:08:27.761 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:27.763 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:27.764 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:27.765 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:27.766 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Jan 08, 2019 04:08:27.767 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:27.768 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Jan 08, 2019 04:08:27.769 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - All info found
Jan 08, 2019 04:08:27.769 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 8321 bytes read:78769 seeks:2 frames:34
Jan 08, 2019 04:08:27.770 [0x7f7a0cfa7840] DEBUG - [MI]  * 6ad524d414c40723480571ba51aaa48f161ce4ea [mkv h264/aac] Duration: 1568000ms, 640x480 (1.333333) 23.976fps, bitrate=937kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/nfs/media/Videos/TV Shows/MASH/Season 3/3x03 - Officer of the Day.mkv")
Jan 08, 2019 04:08:27.771 [0x7f7a0cfa7840] DEBUG - [MI] Importing 11 media chapters.
Jan 08, 2019 04:08:27.771 [0x7f7a0cfa7840] DEBUG - [MI] Chapters had generic titles, clearing.
Jan 08, 2019 04:08:27.773 [0x7f7a0cfa7840] DEBUG - [MI] Closing input file: "/mnt/nfs/media/Videos/TV Shows/MASH/Season 3/3x03 - Officer of the Day.mkv"
Jan 08, 2019 04:08:27.775 [0x7f7a0cfa7840] DEBUG - [FFMPEG] - Statistics: 78769 bytes read, 2 seeks
Jan 08, 2019 04:08:27.776 [0x7f7a0cfa7840] DEBUG - Committing media stream changes for part 29141
Jan 08, 2019 04:08:27.778 [0x7f7a0cfa7840] DEBUG - Updating media item 21837, size=183662075, metadata_item_id=9761
Jan 08, 2019 04:08:27.778 [0x7f7a0cfa7840] DEBUG - Updating part with ID=29141 [/mnt/nfs/media/Videos/TV Shows/MASH/Season 3/3x03 - Officer of the Day.mkv]
Jan 08, 2019 04:08:27.780 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9761&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:27.782 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9761&metadataType=4&state=-1&mediaState=analyzing
Jan 08, 2019 04:08:27.782 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9761&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:27.784 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9761&metadataType=4&state=-1&mediaState=thumbnailing
Jan 08, 2019 04:08:27.784 [0x7f79f67ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9761&metadataType=4&state=-1&mediaState=idle
Jan 08, 2019 04:08:27.786 [0x7f79f67ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=3&metadataItemID=9761&metadataType=4&state=-1&mediaState=idle
