Feb 04, 2019 00:04:52.043 [0x7f925ba64700] 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:52.043 [0x7f925ba64700] 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:52.043 [0x7f925ba64700] INFO - Processor Intel(R) Core(TM) i5 CPU       M 480  @ 2.67GHz
Feb 04, 2019 00:04:52.043 [0x7f925ba64700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze --item 4073,8362,8450,8476,8413,4069,8317 --log-file-suffix  Analysis
Feb 04, 2019 00:04:52.051 [0x7f9267262d00] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Feb 04, 2019 00:04:52.211 [0x7f9267262d00] DEBUG - It took 10.000000 ms to retrieve 170 items.
Feb 04, 2019 00:04:52.229 [0x7f9267262d00] DEBUG - Analyzing media parts for item 4073 (Iron Man 3): 10551
Feb 04, 2019 00:04:52.230 [0x7f9267262d00] DEBUG - [ID 10608] Media part analysis: /mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4
Feb 04, 2019 00:04:52.537 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4"
Feb 04, 2019 00:04:52.538 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4' for reading
Feb 04, 2019 00:04:52.538 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:52.636 [0x7f9267262d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:52.636 [0x7f9267262d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:52.648 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:52.719 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:52.719 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 187988808
Feb 04, 2019 00:04:52.728 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:52.828 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 375979008
Feb 04, 2019 00:04:52.851 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4093141242 bytes read:4021380 seeks:1 nb_streams:2
Feb 04, 2019 00:04:52.851 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:52.851 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:52.854 [0x7f9267262d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:52.854 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:52.854 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:52.855 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3424 bytes read:4054148 seeks:2 frames:3
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 4089152590 at offset 40
Feb 04, 2019 00:04:52.857 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found moov atom of size 3988612 at offset 4089152630
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 1565568 at offset 4089152746
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 2422832 at offset 4090718314
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 1565420 at offset 4089152894
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 1565335 at offset 4089152979
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 1565271 at offset 4089153043
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2422696 at offset 4090718450
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 2422611 at offset 4090718535
Feb 04, 2019 00:04:52.860 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2422551 at offset 4090718595
Feb 04, 2019 00:04:52.861 [0x7f9267262d00] DEBUG - [MI]  * b1493d503e3649ce2d87cb3039a05589e92c2a3b [mp4 h264/aac] Duration: 7832896ms, 1280x720 (1.777778) 23.976fps, bitrate=4180kbps, audio channels=2, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4")
Feb 04, 2019 00:04:52.862 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:52.863 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4"
Feb 04, 2019 00:04:52.864 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 4054148 bytes read, 2 seeks
Feb 04, 2019 00:04:52.864 [0x7f9267262d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:52.865 [0x7f9267262d00] DEBUG - Updating media item 10551, size=4093141242, metadata_item_id=4073
Feb 04, 2019 00:04:52.865 [0x7f9267262d00] DEBUG - Updating part with ID=10608 [/mnt/wd/4t/Plex/Movies/Marvel/Iron Man - III (2013).mp4]
Feb 04, 2019 00:04:53.851 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4073&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:53.857 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4073&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:53.858 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4073&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:53.860 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4073&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:53.861 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4073&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:53.863 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4073&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:53.864 [0x7f9267262d00] DEBUG - It took 10.000000 ms to retrieve 108 items.
Feb 04, 2019 00:04:53.872 [0x7f9267262d00] DEBUG - Analyzing media parts for item 8362 (Aftermath): 10368
Feb 04, 2019 00:04:53.872 [0x7f9267262d00] DEBUG - [ID 10425] Media part analysis: /mnt/wd/4t/Plex/Movies/Downloads/Aftermath.2017.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv
Feb 04, 2019 00:04:53.905 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Downloads/Aftermath.2017.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv"
Feb 04, 2019 00:04:53.905 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Downloads/Aftermath.2017.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv' for reading
Feb 04, 2019 00:04:53.905 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:53.945 [0x7f9267262d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:53.950 [0x7f9267262d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:53.950 [0x7f9267262d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:53.950 [0x7f9267262d00] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:53.951 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 68405 bytes read:98304 seeks:0 nb_streams:7
Feb 04, 2019 00:04:53.951 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 1
Feb 04, 2019 00:04:53.951 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 1
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=5035
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=5033
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=5007
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=4988
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=4972
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - index=0
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[0]: 0
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - index=1
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[1]: 0
Feb 04, 2019 00:04:53.953 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=4838
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - sof0: picture: 120x176
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - pix fmt id 11111100
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=4819
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - escaping removed 17 bytes
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=4679
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 4662 bytes (37296 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=8560
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=8558
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=8532
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ed avail_size_in_buf=8513
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 43 bytes (344 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=8467
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=8451
Feb 04, 2019 00:04:53.954 [0x7f9267262d00] DEBUG - [FFMPEG] - index=0
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[0]: 0
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - index=1
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[1]: 0
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=8317
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - sof0: picture: 213x120
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - pix fmt id 11111100
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=8298
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - escaping removed 28 bytes
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=8136
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 8108 bytes (64864 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=23752
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=23750
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=23724
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=23705
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=23689
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - index=0
Feb 04, 2019 00:04:53.955 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[0]: 0
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - index=1
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[1]: 0
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=23555
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - sof0: picture: 600x882
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - pix fmt id 11111100
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=23536
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - escaping removed 102 bytes
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=23337
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 23235 bytes (185880 bits)
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d8 avail_size_in_buf=24550
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=e1 avail_size_in_buf=24548
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 23 bytes (184 bits)
Feb 04, 2019 00:04:53.956 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ec avail_size_in_buf=24522
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 16 bytes (128 bits)
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ed avail_size_in_buf=24503
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 43 bytes (344 bits)
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=ee avail_size_in_buf=24457
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 14 bytes (112 bits)
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=db avail_size_in_buf=24441
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - index=0
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[0]: 0
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - index=1
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - qscale[1]: 0
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 132 bytes (1056 bits)
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c0 avail_size_in_buf=24307
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - Changing bps from 0 to 8
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - sof0: picture: 1067x600
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - component 0 1:1 id: 0 quant:0
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - component 1 1:1 id: 1 quant:1
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - component 2 1:1 id: 2 quant:1
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - pix fmt id 11111100
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuvj444p chosen by get_format().
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 17 bytes (136 bits)
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=c4 avail_size_in_buf=24288
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 0 bytes (0 bits)
Feb 04, 2019 00:04:53.957 [0x7f9267262d00] DEBUG - [FFMPEG] - escaping removed 91 bytes
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=da avail_size_in_buf=24087
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - marker parser used 23996 bytes (191968 bits)
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - marker=d9 avail_size_in_buf=0
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - decode frame unused 0 bytes
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 1
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 1
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.958 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.959 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.959 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.959 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.959 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 1
Feb 04, 2019 00:04:53.959 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.964 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.966 [0x7f9267262d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.968 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.969 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.969 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.974 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.978 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.983 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.987 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.991 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 1
Feb 04, 2019 00:04:53.995 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:53.995 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 95814 bytes read:98304 seeks:0 frames:29
Feb 04, 2019 00:04:53.996 [0x7f9267262d00] DEBUG - [MI]  * b4d947e2d64d82be612cd0a76d326b855262b281 [mkv h264/ac3] Duration: 5635200ms, 1912x792 (2.414141) 23.976fps, bitrate=5023kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Downloads/Aftermath.2017.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv")
Feb 04, 2019 00:04:53.996 [0x7f9267262d00] DEBUG - [MI] Importing 10 media chapters.
Feb 04, 2019 00:04:53.997 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:53.999 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Downloads/Aftermath.2017.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv"
Feb 04, 2019 00:04:54.000 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 98304 bytes read, 0 seeks
Feb 04, 2019 00:04:54.001 [0x7f9267262d00] DEBUG - Committing media stream changes for part 10425
Feb 04, 2019 00:04:54.016 [0x7f9267262d00] DEBUG - Updating media item 10368, size=3538664664, metadata_item_id=8362
Feb 04, 2019 00:04:54.016 [0x7f9267262d00] DEBUG - Updating part with ID=10425 [/mnt/wd/4t/Plex/Movies/Downloads/Aftermath.2017.1080p.WEB-DL.DD5.1.H264-FGT[EtHD].mkv]
Feb 04, 2019 00:04:54.039 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8362&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.041 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8362&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.041 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8362&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.042 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8362&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.043 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8362&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.045 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8362&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.060 [0x7f9267262d00] DEBUG - Analyzing media parts for item 8450 (The Mummy): 10456
Feb 04, 2019 00:04:54.060 [0x7f9267262d00] DEBUG - [ID 10513] Media part analysis: /mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4
Feb 04, 2019 00:04:54.060 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4"
Feb 04, 2019 00:04:54.060 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4' for reading
Feb 04, 2019 00:04:54.061 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:54.101 [0x7f9267262d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:54.101 [0x7f9267262d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:54.121 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:54.181 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 0, duration: 82334208
Feb 04, 2019 00:04:54.190 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:54.372 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 1024, duration: 295485876
Feb 04, 2019 00:04:54.372 [0x7f9267262d00] DEBUG - [FFMPEG] - drop a frame at curr_cts: 0 @ 0
Feb 04, 2019 00:04:54.385 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:54.385 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 2, edit list 0 - media time: 0, duration: 6700360
Feb 04, 2019 00:04:54.385 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4279532727 bytes read:5925770 seeks:3 nb_streams:3
Feb 04, 2019 00:04:54.386 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:54.386 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:54.387 [0x7f9267262d00] DEBUG - [FFMPEG] - demuxer injecting skip 1024 / discard 0
Feb 04, 2019 00:04:54.387 [0x7f9267262d00] DEBUG - [FFMPEG] - skip 1024 / discard 0 samples due to side data
Feb 04, 2019 00:04:54.387 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:54.387 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:54.387 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 7382 bytes read:5958538 seeks:4 frames:2
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 4273672453 at offset 40
Feb 04, 2019 00:04:54.392 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found moov atom of size 5860234 at offset 4273672493
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 1296787 at offset 4273672609
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 4562104 at offset 4274969396
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 671 at offset 4279531500
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 1296631 at offset 4273672765
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 1296546 at offset 4273672850
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 1296482 at offset 4273672914
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 4273672745
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 4273672753
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 4561920 at offset 4274969552
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 4561835 at offset 4274969637
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 4561775 at offset 4274969697
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found tref atom of size 20 at offset 4274969532
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found chap atom of size 12 at offset 4274969540
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - [MI] Determined stream id 3 has chapters, not subtitles
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 535 at offset 4279531636
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 447 at offset 4279531724
Feb 04, 2019 00:04:54.396 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 327 at offset 4279531844
Feb 04, 2019 00:04:54.397 [0x7f9267262d00] DEBUG - [MI]  * 78a4a3e8abf3a9b8e3ce2b5e9fcdccd94feea5e4 [mp4 h264/aac] Duration: 6700384ms, 1920x1080 (1.777778) 24.000fps, bitrate=5109kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4")
Feb 04, 2019 00:04:54.398 [0x7f9267262d00] DEBUG - [MI] Importing 20 media chapters.
Feb 04, 2019 00:04:54.398 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:54.401 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4"
Feb 04, 2019 00:04:54.402 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 5958538 bytes read, 4 seeks
Feb 04, 2019 00:04:54.402 [0x7f9267262d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:54.402 [0x7f9267262d00] DEBUG - Updating media item 10456, size=4279532727, metadata_item_id=8450
Feb 04, 2019 00:04:54.403 [0x7f9267262d00] DEBUG - Updating part with ID=10513 [/mnt/wd/4t/Plex/Movies/The Mummy/The Mummy (1999).mp4]
Feb 04, 2019 00:04:54.424 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8450&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.426 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8450&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.427 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8450&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.429 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8450&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.429 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8450&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.432 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8450&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.439 [0x7f9267262d00] DEBUG - It took 10.000000 ms to retrieve 146 items.
Feb 04, 2019 00:04:54.450 [0x7f9267262d00] DEBUG - Analyzing media parts for item 8476 (Die Hard): 10482
Feb 04, 2019 00:04:54.450 [0x7f9267262d00] DEBUG - [ID 10539] Media part analysis: /mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4
Feb 04, 2019 00:04:54.465 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4"
Feb 04, 2019 00:04:54.465 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4' for reading
Feb 04, 2019 00:04:54.465 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:54.489 [0x7f9267262d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:54.489 [0x7f9267262d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:54.513 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:54.587 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:54.587 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 185393208
Feb 04, 2019 00:04:54.596 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:54.691 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 370788384
Feb 04, 2019 00:04:54.712 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 4042532165 bytes read:3966313 seeks:1 nb_streams:2
Feb 04, 2019 00:04:54.713 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:54.713 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:54.714 [0x7f9267262d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:54.714 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:54.714 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:54.714 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 6889 bytes read:3999081 seeks:2 frames:3
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 4038598580 at offset 40
Feb 04, 2019 00:04:54.719 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found moov atom of size 3933545 at offset 4038598620
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 1543957 at offset 4038598736
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 2389376 at offset 4040142693
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 1543809 at offset 4038598884
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 1543724 at offset 4038598969
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 1543660 at offset 4038599033
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2389240 at offset 4040142829
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 2389155 at offset 4040142914
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2389095 at offset 4040142974
Feb 04, 2019 00:04:54.722 [0x7f9267262d00] DEBUG - [MI]  * a442edfc687ea735d24c348f2c8640bb4acc2e81 [mp4 h264/aac] Duration: 7724758ms, 1920x1080 (1.777778) 23.976fps, bitrate=4186kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4")
Feb 04, 2019 00:04:54.723 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:54.723 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4"
Feb 04, 2019 00:04:54.725 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 3999081 bytes read, 2 seeks
Feb 04, 2019 00:04:54.725 [0x7f9267262d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:54.725 [0x7f9267262d00] DEBUG - Updating media item 10482, size=4042532165, metadata_item_id=8476
Feb 04, 2019 00:04:54.725 [0x7f9267262d00] DEBUG - Updating part with ID=10539 [/mnt/wd/4t/Plex/Movies/Die Hard/Live Free or Die Hard (2007).mp4]
Feb 04, 2019 00:04:54.743 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8476&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.744 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8476&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.745 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8476&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.746 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8476&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.746 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8476&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.748 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8476&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.758 [0x7f9267262d00] DEBUG - Analyzing media parts for item 8413 (The Girl with All the Gifts): 10419
Feb 04, 2019 00:04:54.758 [0x7f9267262d00] DEBUG - [ID 10476] Media part analysis: /mnt/wd/4t/Plex/Movies/Downloads/The.Girl.with.All.the.Gifts.2016.mkv
Feb 04, 2019 00:04:54.777 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Downloads/The.Girl.with.All.the.Gifts.2016.mkv"
Feb 04, 2019 00:04:54.777 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Downloads/The.Girl.with.All.the.Gifts.2016.mkv' for reading
Feb 04, 2019 00:04:54.777 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:54.789 [0x7f9267262d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:54.801 [0x7f9267262d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:54.801 [0x7f9267262d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:54.801 [0x7f9267262d00] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - st:3 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 6483 bytes read:34403 seeks:2 nb_streams:4
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 32(VPS), nuh_layer_id: 0, temporal_id: 0
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Decoding VPS
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Main 10 profile bitstream
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 33(SPS), nuh_layer_id: 0, temporal_id: 0
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Decoding SPS
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Main 10 profile bitstream
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Decoding VUI
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 34(PPS), nuh_layer_id: 0, temporal_id: 0
Feb 04, 2019 00:04:54.802 [0x7f9267262d00] DEBUG - [FFMPEG] - Decoding PPS
Feb 04, 2019 00:04:54.822 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:54.822 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 17761 bytes read:67171 seeks:2 frames:11
Feb 04, 2019 00:04:54.822 [0x7f9267262d00] DEBUG - [MI]  * 63244359b8667443478ea8f2dfe15015e1f9c7a1 [mkv hevc/aac] Duration: 6655482ms, 1920x960 (2.000000) 23.976fps, bitrate=2253kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Downloads/The.Girl.with.All.the.Gifts.2016.mkv")
Feb 04, 2019 00:04:54.824 [0x7f9267262d00] DEBUG - [MI] Importing 12 media chapters.
Feb 04, 2019 00:04:54.824 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:54.829 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Downloads/The.Girl.with.All.the.Gifts.2016.mkv"
Feb 04, 2019 00:04:54.831 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 67171 bytes read, 2 seeks
Feb 04, 2019 00:04:54.831 [0x7f9267262d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:54.832 [0x7f9267262d00] DEBUG - Updating media item 10419, size=1875157160, metadata_item_id=8413
Feb 04, 2019 00:04:54.832 [0x7f9267262d00] DEBUG - Updating part with ID=10476 [/mnt/wd/4t/Plex/Movies/Downloads/The.Girl.with.All.the.Gifts.2016.mkv]
Feb 04, 2019 00:04:54.850 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8413&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.852 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8413&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:54.852 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8413&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.853 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8413&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:54.853 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8413&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.855 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8413&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:54.861 [0x7f9267262d00] DEBUG - It took 0.000000 ms to retrieve 143 items.
Feb 04, 2019 00:04:54.875 [0x7f9267262d00] DEBUG - Analyzing media parts for item 4069 (Guardians of the Galaxy): 10547
Feb 04, 2019 00:04:54.875 [0x7f9267262d00] DEBUG - [ID 10604] Media part analysis: /mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4
Feb 04, 2019 00:04:54.882 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4"
Feb 04, 2019 00:04:54.882 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4' for reading
Feb 04, 2019 00:04:54.882 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:54.906 [0x7f9267262d00] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Feb 04, 2019 00:04:54.906 [0x7f9267262d00] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Feb 04, 2019 00:04:54.922 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:55.000 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: -1, duration: 984
Feb 04, 2019 00:04:55.001 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 0, edit list 1 - media time: 0, duration: 174028872
Feb 04, 2019 00:04:55.009 [0x7f9267262d00] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Feb 04, 2019 00:04:55.101 [0x7f9267262d00] DEBUG - [FFMPEG] - Processing st: 1, edit list 0 - media time: 0, duration: 348058656
Feb 04, 2019 00:04:55.121 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 3802922853 bytes read:3725248 seeks:1 nb_streams:2
Feb 04, 2019 00:04:55.122 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:55.122 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:55.123 [0x7f9267262d00] DEBUG - [FFMPEG] - skip whole frame, skip left: 0
Feb 04, 2019 00:04:55.123 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:55.123 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:55.123 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3459 bytes read:3758016 seeks:2 frames:3
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - [MI] Opening "/mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4" for MP4 atom parsing
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping free atom of size 8 at offset 32
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - Mp4AtomParser: Skipping mdat atom of size 3799230333 at offset 40
Feb 04, 2019 00:04:55.125 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found moov atom of size 3692480 at offset 3799230373
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 1449348 at offset 3799230489
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found trak atom of size 2242920 at offset 3800679837
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 1449200 at offset 3799230637
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 1449115 at offset 3799230722
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 1449051 at offset 3799230786
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found mdia atom of size 2242784 at offset 3800679973
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found minf atom of size 2242699 at offset 3800680058
Feb 04, 2019 00:04:55.128 [0x7f9267262d00] DEBUG - Mp4AtomParser: Found stbl atom of size 2242639 at offset 3800680118
Feb 04, 2019 00:04:55.129 [0x7f9267262d00] DEBUG - [MI]  * f3e74391a0c1c557d481d35c2abe7c097f7e282d [mp4 h264/aac] Duration: 7251222ms, 1280x720 (1.777778) 23.976fps, bitrate=4195kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4")
Feb 04, 2019 00:04:55.129 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:55.129 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4"
Feb 04, 2019 00:04:55.130 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 3758016 bytes read, 2 seeks
Feb 04, 2019 00:04:55.131 [0x7f9267262d00] DEBUG - Streams didn't change in analysis, not saving.
Feb 04, 2019 00:04:55.131 [0x7f9267262d00] DEBUG - Updating media item 10547, size=3802922853, metadata_item_id=4069
Feb 04, 2019 00:04:55.131 [0x7f9267262d00] DEBUG - Updating part with ID=10604 [/mnt/wd/4t/Plex/Movies/Marvel/Guardians Of The Galaxy (2014).mp4]
Feb 04, 2019 00:04:55.179 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4069&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:55.181 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4069&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:55.182 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4069&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:55.184 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4069&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:55.184 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4069&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:55.186 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=4069&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:55.192 [0x7f9267262d00] DEBUG - It took 0.000000 ms to retrieve 105 items.
Feb 04, 2019 00:04:55.201 [0x7f9267262d00] DEBUG - Analyzing media parts for item 8317 (The League of Extraordinary Gentlemen): 10323
Feb 04, 2019 00:04:55.201 [0x7f9267262d00] DEBUG - [ID 10380] Media part analysis: /mnt/wd/4t/Plex/Movies/The League of Extraordinary Gentlemen (2003).mkv
Feb 04, 2019 00:04:55.210 [0x7f9267262d00] DEBUG - [MI] Opening input file: "/mnt/wd/4t/Plex/Movies/The League of Extraordinary Gentlemen (2003).mkv"
Feb 04, 2019 00:04:55.210 [0x7f9267262d00] DEBUG - [FFMPEG] - Opening '/mnt/wd/4t/Plex/Movies/The League of Extraordinary Gentlemen (2003).mkv' for reading
Feb 04, 2019 00:04:55.210 [0x7f9267262d00] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Feb 04, 2019 00:04:55.224 [0x7f9267262d00] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Feb 04, 2019 00:04:55.249 [0x7f9267262d00] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:55.249 [0x7f9267262d00] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:55.249 [0x7f9267262d00] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Feb 04, 2019 00:04:55.249 [0x7f9267262d00] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 835 bytes read:65536 seeks:2 nb_streams:3
Feb 04, 2019 00:04:55.249 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:55.249 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:55.250 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Feb 04, 2019 00:04:55.250 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Feb 04, 2019 00:04:55.250 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Feb 04, 2019 00:04:55.250 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Feb 04, 2019 00:04:55.250 [0x7f9267262d00] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Feb 04, 2019 00:04:55.253 [0x7f9267262d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:55.254 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:55.256 [0x7f9267262d00] DEBUG - [FFMPEG] - no picture 
Feb 04, 2019 00:04:55.258 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:55.263 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:55.268 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:55.273 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:55.275 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Feb 04, 2019 00:04:55.279 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:55.283 [0x7f9267262d00] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Feb 04, 2019 00:04:55.286 [0x7f9267262d00] DEBUG - [FFMPEG] - All info found
Feb 04, 2019 00:04:55.286 [0x7f9267262d00] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 28392 bytes read:98304 seeks:2 frames:36
Feb 04, 2019 00:04:55.287 [0x7f9267262d00] DEBUG - [MI]  * 1c9cc4c205c5624fcd6c0085932c693d17844e0d [mkv h264/ac3] Duration: 6606946ms, 1918x812 (2.362069) 23.976fps, bitrate=6152kbps, audio channels=6, optimizedForStreaming=0 ("/mnt/wd/4t/Plex/Movies/The League of Extraordinary Gentlemen (2003).mkv")
Feb 04, 2019 00:04:55.287 [0x7f9267262d00] DEBUG - [MI] Importing 32 media chapters.
Feb 04, 2019 00:04:55.288 [0x7f9267262d00] DEBUG - [MI] Chapters had generic titles, clearing.
Feb 04, 2019 00:04:55.291 [0x7f9267262d00] DEBUG - Doing expensive tags write for 'The League of Extraordinary Gentlemen' because something changed.
Feb 04, 2019 00:04:55.355 [0x7f9267262d00] DEBUG - [MI] Closing input file: "/mnt/wd/4t/Plex/Movies/The League of Extraordinary Gentlemen (2003).mkv"
Feb 04, 2019 00:04:55.356 [0x7f9267262d00] DEBUG - [FFMPEG] - Statistics: 98304 bytes read, 2 seeks
Feb 04, 2019 00:04:55.357 [0x7f9267262d00] DEBUG - Committing media stream changes for part 10380
Feb 04, 2019 00:04:55.366 [0x7f9267262d00] DEBUG - Updating media item 10323, size=5081378789, metadata_item_id=8317
Feb 04, 2019 00:04:55.366 [0x7f9267262d00] DEBUG - Updating part with ID=10380 [/mnt/wd/4t/Plex/Movies/The League of Extraordinary Gentlemen (2003).mkv]
Feb 04, 2019 00:04:55.397 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8317&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:55.399 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8317&metadataType=1&state=-1&mediaState=analyzing
Feb 04, 2019 00:04:55.399 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8317&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:55.401 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8317&metadataType=1&state=-1&mediaState=thumbnailing
Feb 04, 2019 00:04:55.401 [0x7f9253fff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8317&metadataType=1&state=-1&mediaState=idle
Feb 04, 2019 00:04:55.403 [0x7f9253fff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=4&metadataItemID=8317&metadataType=1&state=-1&mediaState=idle
