Oct 31, 2018 03:01:42.571 [0x7f61d6630700] INFO - Plex Media Scanner v1.13.8.5395-10d48da0d - ubuntu PC x86_64 - build: linux-ubuntu-x86_64 - GMT 00:00
Oct 31, 2018 03:01:42.571 [0x7f61d6630700] INFO - Linux version: 4.15.0-33201808301234-generic (#0+mediatree+hauppauge-Ubuntu SMP Thu Aug 30 19:04:43 UTC 2018), language: en-GB
Oct 31, 2018 03:01:42.571 [0x7f61d6630700] INFO - Processor         Intel(R) Core(TM) i5-3330 CPU @ 3.00GHz
Oct 31, 2018 03:01:42.571 [0x7f61d6630700] INFO - /usr/lib/plexmediaserver/Plex Media Scanner --analyze --item 594,574,1771,1697,240,2053,247,17193,1643,1365 --log-file-suffix  Analysis
Oct 31, 2018 03:01:42.576 [0x7f61e2672d40] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Oct 31, 2018 03:01:42.694 [0x7f61e2672d40] DEBUG - It took 0.000000 ms to retrieve 104 items.
Oct 31, 2018 03:01:42.742 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 594 (Fast Five): 647
Oct 31, 2018 03:01:42.742 [0x7f61e2672d40] DEBUG - [ID 647] Media part analysis: /media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4
Oct 31, 2018 03:01:42.742 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4"
Oct 31, 2018 03:01:42.743 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4' for reading
Oct 31, 2018 03:01:42.743 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:42.818 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:42.818 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:42.819 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:43.108 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:43.108 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:43.241 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 2075316420 bytes read:3889000 seeks:1 nb_streams:2
Oct 31, 2018 03:01:43.242 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:43.242 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:43.246 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:43.246 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:43.246 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:43.249 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:43.252 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:43.254 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:43.256 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:43.260 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:43.264 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:43.267 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:43.269 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:43.272 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:43.274 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:43.276 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:43.276 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3860892 bytes read:3921768 seeks:2 frames:13
Oct 31, 2018 03:01:43.276 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:43.279 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 31, 2018 03:01:43.279 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 3858817 at offset 24
Oct 31, 2018 03:01:43.280 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 2121550 at offset 161
Oct 31, 2018 03:01:43.280 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1737130 at offset 2121711
Oct 31, 2018 03:01:43.280 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 2121450 at offset 261
Oct 31, 2018 03:01:43.281 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 2121327 at offset 384
Oct 31, 2018 03:01:43.281 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 2121263 at offset 448
Oct 31, 2018 03:01:43.281 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1737030 at offset 2121811
Oct 31, 2018 03:01:43.281 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1736938 at offset 2121903
Oct 31, 2018 03:01:43.281 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1736878 at offset 2121963
Oct 31, 2018 03:01:43.282 [0x7f61e2672d40] DEBUG - [MI]  * e14c1b9db9e65284c4122c8e7897d8cfde02b933 [mp4 h264/aac] Duration: 7821353ms, 1920x816 (2.352941) 23.976fps, bitrate=2122kbps, audio channels=2, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4")
Oct 31, 2018 03:01:43.283 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:43.283 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4"
Oct 31, 2018 03:01:43.285 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 3921768 bytes read, 2 seeks
Oct 31, 2018 03:01:43.287 [0x7f61e2672d40] DEBUG - Updating media item 647, size=2075316455, metadata_item_id=594
Oct 31, 2018 03:01:43.288 [0x7f61e2672d40] DEBUG - Updating part with ID=647 [/media/NAS/Shared_Videos/Fast Five (2011)/Fast Five.mp4]
Oct 31, 2018 03:01:43.357 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=594&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:43.359 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=594&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:43.359 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=594&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:43.362 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=594&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:43.362 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=594&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:43.363 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=594&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:43.407 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 574 (Ender's Game): 627
Oct 31, 2018 03:01:43.407 [0x7f61e2672d40] DEBUG - [ID 627] Media part analysis: /media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4
Oct 31, 2018 03:01:43.407 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4"
Oct 31, 2018 03:01:43.407 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4' for reading
Oct 31, 2018 03:01:43.407 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:43.477 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:43.477 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:43.477 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:43.678 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:43.678 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:43.833 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:43.989 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 2108719096 bytes read:4601354 seeks:1 nb_streams:3
Oct 31, 2018 03:01:43.989 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:43.989 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:43.992 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:43.992 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:43.992 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:43.995 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:43.997 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:43.999 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:44.001 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.006 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.009 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.013 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.016 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.017 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.020 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.023 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:44.023 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4603728 bytes read:4634122 seeks:2 frames:37
Oct 31, 2018 03:01:44.023 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:44.028 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 31, 2018 03:01:44.028 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 4595283 at offset 24
Oct 31, 2018 03:01:44.030 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1561900 at offset 161
Oct 31, 2018 03:01:44.030 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1516727 at offset 1562061
Oct 31, 2018 03:01:44.030 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1516519 at offset 3078788
Oct 31, 2018 03:01:44.030 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1561800 at offset 261
Oct 31, 2018 03:01:44.030 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1561727 at offset 334
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1561663 at offset 398
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1516627 at offset 1562161
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1516554 at offset 1562234
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1516494 at offset 1562294
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1516419 at offset 3078888
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1516346 at offset 3078961
Oct 31, 2018 03:01:44.031 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1516286 at offset 3079021
Oct 31, 2018 03:01:44.032 [0x7f61e2672d40] DEBUG - [MI]  * ebadc1e38a24d65f81834c55aa7190eafdda541c [mp4 h264/aac] Duration: 6828948ms, 1920x800 (2.400000) 23.976fps, bitrate=2470kbps, audio channels=6, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4")
Oct 31, 2018 03:01:44.033 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:44.033 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4"
Oct 31, 2018 03:01:44.035 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 4634122 bytes read, 2 seeks
Oct 31, 2018 03:01:44.037 [0x7f61e2672d40] DEBUG - Committing media stream changes for part 627
Oct 31, 2018 03:01:44.047 [0x7f61e2672d40] DEBUG - Updating media item 627, size=2108719131, metadata_item_id=574
Oct 31, 2018 03:01:44.047 [0x7f61e2672d40] DEBUG - Updating part with ID=627 [/media/NAS/Shared_Videos/Enders.Game.2013.1080p.BluRay.x264.anoXmous/Enders.Game.2013.1080p.BluRay.x264.anoXmous_.mp4]
Oct 31, 2018 03:01:44.066 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=574&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:44.067 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=574&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:44.067 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=574&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:44.068 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=574&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:44.069 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=574&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:44.069 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=574&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:44.124 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 1771 (The Watch): 2098
Oct 31, 2018 03:01:44.124 [0x7f61e2672d40] DEBUG - [ID 2101] Media part analysis: /media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4
Oct 31, 2018 03:01:44.124 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4"
Oct 31, 2018 03:01:44.124 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4' for reading
Oct 31, 2018 03:01:44.124 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:44.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:44.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:44.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:44.404 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:44.404 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:44.632 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1721831896 bytes read:3179908 seeks:1 nb_streams:2
Oct 31, 2018 03:01:44.632 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:44.632 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:44.633 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:44.633 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:44.633 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:44.635 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:44.638 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.640 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:44.642 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.648 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.651 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.655 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.657 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:44.659 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.662 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:44.666 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:44.666 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3169575 bytes read:3212676 seeks:2 frames:13
Oct 31, 2018 03:01:44.666 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:44.669 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 31, 2018 03:01:44.669 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 3167637 at offset 24
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1808855 at offset 161
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1358645 at offset 1809016
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1808755 at offset 261
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1808682 at offset 334
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1808618 at offset 398
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1358545 at offset 1809116
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1358450 at offset 1809211
Oct 31, 2018 03:01:44.670 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1358390 at offset 1809271
Oct 31, 2018 03:01:44.672 [0x7f61e2672d40] DEBUG - [MI]  * 20ce869682696f77126b13018465f763f9b714dc [mp4 h264/aac] Duration: 6117013ms, 1920x816 (2.352941) 23.976fps, bitrate=2251kbps, audio channels=2, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4")
Oct 31, 2018 03:01:44.672 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:44.673 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4"
Oct 31, 2018 03:01:44.675 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 3212676 bytes read, 2 seeks
Oct 31, 2018 03:01:44.678 [0x7f61e2672d40] DEBUG - Updating media item 2098, size=1721831927, metadata_item_id=1771
Oct 31, 2018 03:01:44.678 [0x7f61e2672d40] DEBUG - Updating part with ID=2101 [/media/NAS/Shared_Videos/The Watch (2012) [1080p]/The.Watch.2012.1080p.BluRay.x264.YIFY.mp4]
Oct 31, 2018 03:01:44.704 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1771&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:44.705 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1771&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:44.705 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1771&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:44.706 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1771&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:44.706 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1771&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:44.707 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1771&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:44.729 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 1697 (The Matrix Revolutions): 2009
Oct 31, 2018 03:01:44.729 [0x7f61e2672d40] DEBUG - [ID 2012] Media part analysis: /media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4
Oct 31, 2018 03:01:44.729 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4"
Oct 31, 2018 03:01:44.729 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4' for reading
Oct 31, 2018 03:01:44.729 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:44.786 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:44.786 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:44.786 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:44.986 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:44.986 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:45.121 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 733574518 bytes read:2784562 seeks:1 nb_streams:2
Oct 31, 2018 03:01:45.121 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:45.121 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:45.122 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:45.122 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:45.122 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:45.123 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:45.126 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:45.127 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:45.128 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:45.131 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:45.134 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:45.136 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:45.137 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:45.138 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:45.140 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:45.141 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:45.141 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 2755093 bytes read:2817330 seeks:2 frames:13
Oct 31, 2018 03:01:45.141 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:45.146 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 31, 2018 03:01:45.146 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 2753815 at offset 24
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1858519 at offset 161
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 895159 at offset 1858680
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1858419 at offset 261
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1858346 at offset 334
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1858282 at offset 398
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 895059 at offset 1858780
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 894964 at offset 1858875
Oct 31, 2018 03:01:45.147 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 894904 at offset 1858935
Oct 31, 2018 03:01:45.149 [0x7f61e2672d40] DEBUG - [MI]  * 6fd5e25e169437ea2506ce4b731f14f3c9140fdf [mp4 h264/aac] Duration: 7756073ms, 1280x532 (2.406015) 23.976fps, bitrate=756kbps, audio channels=2, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4")
Oct 31, 2018 03:01:45.149 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:45.149 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4"
Oct 31, 2018 03:01:45.151 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 2817330 bytes read, 2 seeks
Oct 31, 2018 03:01:45.153 [0x7f61e2672d40] DEBUG - Updating media item 2009, size=733574549, metadata_item_id=1697
Oct 31, 2018 03:01:45.153 [0x7f61e2672d40] DEBUG - Updating part with ID=2012 [/media/NAS/Shared_Videos/The Matrix Revolutions (2003)/The.Matrix.Revolutions.2003.720p.BrRip.264.YIFY.mp4]
Oct 31, 2018 03:01:45.187 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1697&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:45.188 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1697&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:45.188 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1697&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:45.189 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1697&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:45.190 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1697&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:45.191 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1697&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:45.194 [0x7f61e2672d40] DEBUG - It took 10.000000 ms to retrieve 124 items.
Oct 31, 2018 03:01:45.216 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 240 (Big Trouble in Little China): 265
Oct 31, 2018 03:01:45.216 [0x7f61e2672d40] DEBUG - [ID 265] Media part analysis: /media/NAS/Shared_Videos/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG.avi
Oct 31, 2018 03:01:45.216 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG.avi"
Oct 31, 2018 03:01:45.216 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG.avi' for reading
Oct 31, 2018 03:01:45.216 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:45.295 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 31, 2018 03:01:45.295 [0x7f61e2672d40] DEBUG - [FFMPEG] - use odml:1
Oct 31, 2018 03:01:45.651 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:4720844 seeks:73 nb_streams:2
Oct 31, 2018 03:01:45.653 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:45.653 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:45.653 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 45822 bytes read:4753612 seeks:73 frames:16
Oct 31, 2018 03:01:45.653 [0x7f61e2672d40] DEBUG - [MI]  * 686df8b2f149c1f1d5ff762145698037b1c2a512 [avi mpeg4/ac3] Duration: 5987992ms, 1280x544 (2.352941) 23.976fps, bitrate=3780kbps, audio channels=6, optimizedForStreaming=0 ("/media/NAS/Shared_Videos/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG.avi")
Oct 31, 2018 03:01:45.654 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:45.654 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG.avi"
Oct 31, 2018 03:01:45.654 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 4753612 bytes read, 73 seeks
Oct 31, 2018 03:01:45.656 [0x7f61e2672d40] DEBUG - Updating media item 265, size=2829936640, metadata_item_id=240
Oct 31, 2018 03:01:45.657 [0x7f61e2672d40] DEBUG - Updating part with ID=265 [/media/NAS/Shared_Videos/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG/Big.Trouble.In.Little.China.1986.720p.BRRip.XviD.AC3-RARBG.avi]
Oct 31, 2018 03:01:45.679 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=240&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:45.680 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=240&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:45.680 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=240&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:45.681 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=240&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:45.681 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=240&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:45.682 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=240&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:45.698 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 2053 (Heart and Souls): 2450
Oct 31, 2018 03:01:45.698 [0x7f61e2672d40] DEBUG - [ID 2453] Media part analysis: /media/NAS/Shared_Videos/[UsaBit.com] - Heart.And.Souls.1993.WS.DVDRip.XViD.iNT-EwDp/ewdp-heartsouls.xvid.avi
Oct 31, 2018 03:01:45.698 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/[UsaBit.com] - Heart.And.Souls.1993.WS.DVDRip.XViD.iNT-EwDp/ewdp-heartsouls.xvid.avi"
Oct 31, 2018 03:01:45.698 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/[UsaBit.com] - Heart.And.Souls.1993.WS.DVDRip.XViD.iNT-EwDp/ewdp-heartsouls.xvid.avi' for reading
Oct 31, 2018 03:01:45.698 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:45.772 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format avi probed with size=2048 and score=100
Oct 31, 2018 03:01:45.772 [0x7f61e2672d40] DEBUG - [FFMPEG] - use odml:1
Oct 31, 2018 03:01:45.772 [0x7f61e2672d40] DEBUG - [FFMPEG] - st:1 removing common factor 384 from timebase
Oct 31, 2018 03:01:46.413 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 10252 bytes read:6472900 seeks:4 nb_streams:2
Oct 31, 2018 03:01:46.414 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:46.414 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:46.414 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 14242 bytes read:6472900 seeks:4 frames:22
Oct 31, 2018 03:01:46.415 [0x7f61e2672d40] DEBUG - [MI]  * 4471e6750b03b8e2382f9074dbb45cf3a7ef942c [avi mpeg4/mp3] Duration: 5945520ms, 560x240 (2.333333) 25.000fps, bitrate=984kbps, audio channels=2, optimizedForStreaming=0 ("/media/NAS/Shared_Videos/[UsaBit.com] - Heart.And.Souls.1993.WS.DVDRip.XViD.iNT-EwDp/ewdp-heartsouls.xvid.avi")
Oct 31, 2018 03:01:46.415 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:46.415 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/[UsaBit.com] - Heart.And.Souls.1993.WS.DVDRip.XViD.iNT-EwDp/ewdp-heartsouls.xvid.avi"
Oct 31, 2018 03:01:46.416 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 6472900 bytes read, 4 seeks
Oct 31, 2018 03:01:46.418 [0x7f61e2672d40] DEBUG - Updating media item 2450, size=731922432, metadata_item_id=2053
Oct 31, 2018 03:01:46.418 [0x7f61e2672d40] DEBUG - Updating part with ID=2453 [/media/NAS/Shared_Videos/[UsaBit.com] - Heart.And.Souls.1993.WS.DVDRip.XViD.iNT-EwDp/ewdp-heartsouls.xvid.avi]
Oct 31, 2018 03:01:46.443 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2053&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:46.444 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2053&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:46.444 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2053&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:46.445 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2053&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:46.445 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2053&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:46.446 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=2053&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:46.450 [0x7f61e2672d40] DEBUG - It took 10.000000 ms to retrieve 120 items.
Oct 31, 2018 03:01:46.491 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 247 (Blade II): 272
Oct 31, 2018 03:01:46.491 [0x7f61e2672d40] DEBUG - [ID 272] Media part analysis: /media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4
Oct 31, 2018 03:01:46.491 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4"
Oct 31, 2018 03:01:46.491 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4' for reading
Oct 31, 2018 03:01:46.491 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:46.556 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:46.556 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:46.556 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:46.753 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:46.753 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:46.821 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:47.068 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 2165053971 bytes read:4478110 seeks:1 nb_streams:3
Oct 31, 2018 03:01:47.068 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:47.068 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:47.070 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.070 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:47.070 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:47.072 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:47.075 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.077 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:47.079 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.086 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.092 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.099 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.103 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.105 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.109 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.114 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:47.114 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 4482345 bytes read:4510878 seeks:2 frames:37
Oct 31, 2018 03:01:47.114 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:47.117 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 31, 2018 03:01:47.117 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 4473619 at offset 24
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1359764 at offset 161
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1556963 at offset 1359925
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1556755 at offset 2916888
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1359664 at offset 261
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1359591 at offset 334
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1359527 at offset 398
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1556863 at offset 1360025
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1556790 at offset 1360098
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1556730 at offset 1360158
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1556655 at offset 2916988
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1556582 at offset 2917061
Oct 31, 2018 03:01:47.119 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1556522 at offset 2917121
Oct 31, 2018 03:01:47.120 [0x7f61e2672d40] DEBUG - [MI]  * 8f0521466da869b0cf557da48e07b8571be1f7ff [mp4 h264/aac] Duration: 7010090ms, 1920x1078 (1.781076) 23.976fps, bitrate=2470kbps, audio channels=6, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4")
Oct 31, 2018 03:01:47.121 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:47.121 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4"
Oct 31, 2018 03:01:47.124 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 4510878 bytes read, 2 seeks
Oct 31, 2018 03:01:47.126 [0x7f61e2672d40] DEBUG - Committing media stream changes for part 272
Oct 31, 2018 03:01:47.139 [0x7f61e2672d40] DEBUG - Updating media item 272, size=2165054006, metadata_item_id=247
Oct 31, 2018 03:01:47.139 [0x7f61e2672d40] DEBUG - Updating part with ID=272 [/media/NAS/Shared_Videos/Blade.I.II.III.1998-2004.The.Ultimate.Collection.1080p.Bluray.x264.anoXmous/02.Blade.II.2002.1080p.BluRay.x264.anoXmous/Blade.II.2002.1080p.BluRay.x264.anoXmous_.mp4]
Oct 31, 2018 03:01:47.149 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=247&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:47.150 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=247&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:47.150 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=247&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:47.151 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=247&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:47.151 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=247&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:47.152 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 17193 (Three Ghosts): 28435
Oct 31, 2018 03:01:47.152 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=247&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:47.153 [0x7f61e2672d40] DEBUG - [ID 28440] Media part analysis: /media/tvshows3/Arrow/Season 2/E09 - Three Ghosts [720p HDTV 275MB nItRo].mkv
Oct 31, 2018 03:01:47.153 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/tvshows3/Arrow/Season 2/E09 - Three Ghosts [720p HDTV 275MB nItRo].mkv"
Oct 31, 2018 03:01:47.153 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/tvshows3/Arrow/Season 2/E09 - Three Ghosts [720p HDTV 275MB nItRo].mkv' for reading
Oct 31, 2018 03:01:47.153 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format matroska,webm probed with size=2048 and score=100
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - st:0 removing common factor 1000000 from timebase
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - st:1 removing common factor 1000000 from timebase
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - st:2 removing common factor 1000000 from timebase
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 5863 bytes read:32768 seeks:0 nb_streams:3
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:47.208 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:47.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:47.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:47.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:47.209 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:47.210 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:47.211 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.212 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:47.213 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.216 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.219 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.222 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.223 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.224 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.225 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.227 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:47.228 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 9722 bytes read:32768 seeks:0 frames:26
Oct 31, 2018 03:01:47.228 [0x7f61e2672d40] DEBUG - [MI]  * 07a695a8c0bf0d6b1329d4cacbeff627038a8031 [mkv h264/aac] Duration: 2524022ms, 1280x720 (1.777778) 23.976fps, bitrate=911kbps, audio channels=2, optimizedForStreaming=0 ("/media/tvshows3/Arrow/Season 2/E09 - Three Ghosts [720p HDTV 275MB nItRo].mkv")
Oct 31, 2018 03:01:47.229 [0x7f61e2672d40] DEBUG - [MI] Importing 1 media chapters.
Oct 31, 2018 03:01:47.229 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:47.229 [0x7f61e2672d40] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Oct 31, 2018 03:01:47.229 [0x7f61e2672d40] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Oct 31, 2018 03:01:47.231 [0x7f61e2672d40] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Oct 31, 2018 03:01:47.231 [0x7f61e2672d40] DEBUG - Updating metadata item (save) (Three Ghosts) with ID 17193
Oct 31, 2018 03:01:47.239 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Oct 31, 2018 03:01:47.240 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/tvshows3/Arrow/Season 2/E09 - Three Ghosts [720p HDTV 275MB nItRo].mkv"
Oct 31, 2018 03:01:47.240 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/flushMetadataCounterCache
Oct 31, 2018 03:01:47.241 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Oct 31, 2018 03:01:47.242 [0x7f61e2672d40] DEBUG - Committing media stream changes for part 28440
Oct 31, 2018 03:01:47.248 [0x7f61e2672d40] DEBUG - Updating media item 28435, size=287452467, metadata_item_id=17193
Oct 31, 2018 03:01:47.248 [0x7f61e2672d40] DEBUG - Updating part with ID=28440 [/media/tvshows3/Arrow/Season 2/E09 - Three Ghosts [720p HDTV 275MB nItRo].mkv]
Oct 31, 2018 03:01:47.267 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=17193&metadataType=4&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:47.268 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=17193&metadataType=4&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:47.268 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=17193&metadataType=4&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:47.269 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=17193&metadataType=4&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:47.270 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=17193&metadataType=4&state=-1&mediaState=idle
Oct 31, 2018 03:01:47.270 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=2&metadataItemID=17193&metadataType=4&state=-1&mediaState=idle
Oct 31, 2018 03:01:47.278 [0x7f61e2672d40] DEBUG - It took 10.000000 ms to retrieve 194 items.
Oct 31, 2018 03:01:47.326 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 1643 (The Internship): 1951
Oct 31, 2018 03:01:47.326 [0x7f61e2672d40] DEBUG - [ID 1953] Media part analysis: /media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4
Oct 31, 2018 03:01:47.326 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4"
Oct 31, 2018 03:01:47.326 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4' for reading
Oct 31, 2018 03:01:47.326 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:47.424 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:47.424 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:47.424 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:47.712 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:47.712 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:47.848 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1979270213 bytes read:3855761 seeks:1 nb_streams:2
Oct 31, 2018 03:01:47.848 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:47.848 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:47.849 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.849 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.849 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:47.849 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.849 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:47.851 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:47.853 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.853 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.853 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.855 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:47.857 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.857 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.857 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.861 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.861 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.861 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.865 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.865 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.865 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.869 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.869 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.869 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.870 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.870 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:47.870 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.872 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.872 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.872 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.874 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:47.874 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:47.874 [0x7f61e2672d40] DEBUG - [FFMPEG] - ct_type:0 pic_struct:0
Oct 31, 2018 03:01:47.877 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:47.877 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3857552 bytes read:3888529 seeks:2 frames:13
Oct 31, 2018 03:01:47.877 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:47.882 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 24 at offset 0
Oct 31, 2018 03:01:47.882 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 3855566 at offset 24
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 2189328 at offset 161
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1666101 at offset 2189489
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 2189228 at offset 261
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 2189094 at offset 395
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 2189030 at offset 459
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1666001 at offset 2189589
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1665906 at offset 2189684
Oct 31, 2018 03:01:47.884 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1665846 at offset 2189744
Oct 31, 2018 03:01:47.885 [0x7f61e2672d40] DEBUG - [MI]  * 50ea33d2a46c90faaa8b63e5717b43c136a1ef11 [mp4 h264/aac] Duration: 7501482ms, 1920x816 (2.352941) 23.976fps, bitrate=2110kbps, audio channels=2, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4")
Oct 31, 2018 03:01:47.886 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:47.886 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4"
Oct 31, 2018 03:01:47.889 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 3888529 bytes read, 2 seeks
Oct 31, 2018 03:01:47.891 [0x7f61e2672d40] DEBUG - Updating media item 1951, size=1979270240, metadata_item_id=1643
Oct 31, 2018 03:01:47.892 [0x7f61e2672d40] DEBUG - Updating part with ID=1953 [/media/NAS/Shared_Videos/The Internship (2013) [1080p]/The.Internship.2013.UNRATED.1080p.BluRay.x264.YIFY.mp4]
Oct 31, 2018 03:01:47.928 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1643&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:47.929 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1643&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:47.929 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1643&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:47.930 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1643&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:47.930 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1643&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:47.931 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1643&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:47.934 [0x7f61e2672d40] DEBUG - It took 0.000000 ms to retrieve 102 items.
Oct 31, 2018 03:01:47.950 [0x7f61e2672d40] DEBUG - Analyzing media parts for item 1365 (Shaun of the Dead): 1604
Oct 31, 2018 03:01:47.951 [0x7f61e2672d40] DEBUG - [ID 1606] Media part analysis: /media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4
Oct 31, 2018 03:01:47.951 [0x7f61e2672d40] DEBUG - [MI] Opening input file: "/media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4"
Oct 31, 2018 03:01:47.951 [0x7f61e2672d40] DEBUG - [FFMPEG] - Opening '/media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4' for reading
Oct 31, 2018 03:01:47.951 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Oct 31, 2018 03:01:48.032 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Oct 31, 2018 03:01:48.032 [0x7f61e2672d40] DEBUG - [FFMPEG] - ISO: File Type Major Brand: isom
Oct 31, 2018 03:01:48.032 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:48.202 [0x7f61e2672d40] DEBUG - [FFMPEG] - Processing st: 0, edit list 0 - media time: 2002, duration: 143213040
Oct 31, 2018 03:01:48.212 [0x7f61e2672d40] DEBUG - [FFMPEG] - Offset DTS by 2002 to make first pts zero.
Oct 31, 2018 03:01:48.232 [0x7f61e2672d40] DEBUG - [FFMPEG] - Setting codecpar->delay to 2 for stream st: 0
Oct 31, 2018 03:01:48.232 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:48.294 [0x7f61e2672d40] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Oct 31, 2018 03:01:48.456 [0x7f61e2672d40] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 1739185959 bytes read:3987246 seeks:1 nb_streams:3
Oct 31, 2018 03:01:48.456 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 7, nal_ref_idc: 3
Oct 31, 2018 03:01:48.456 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 8, nal_ref_idc: 3
Oct 31, 2018 03:01:48.458 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 6, nal_ref_idc: 0
Oct 31, 2018 03:01:48.458 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 5, nal_ref_idc: 3
Oct 31, 2018 03:01:48.458 [0x7f61e2672d40] DEBUG - [FFMPEG] - Format yuv420p chosen by get_format().
Oct 31, 2018 03:01:48.461 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:48.462 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:48.464 [0x7f61e2672d40] DEBUG - [FFMPEG] - no picture 
Oct 31, 2018 03:01:48.465 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:48.471 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:48.475 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:48.479 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:48.482 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:48.484 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 2
Oct 31, 2018 03:01:48.487 [0x7f61e2672d40] DEBUG - [FFMPEG] - nal_unit_type: 1, nal_ref_idc: 0
Oct 31, 2018 03:01:48.491 [0x7f61e2672d40] DEBUG - [FFMPEG] - All info found
Oct 31, 2018 03:01:48.491 [0x7f61e2672d40] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 3982188 bytes read:4020014 seeks:2 frames:37
Oct 31, 2018 03:01:48.491 [0x7f61e2672d40] DEBUG - [MI] Opening "/media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4" for MP4 atom parsing
Oct 31, 2018 03:01:48.494 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 20 at offset 0
Oct 31, 2018 03:01:48.494 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found moov atom of size 3973667 at offset 20
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1322934 at offset 157
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1325402 at offset 1323091
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found trak atom of size 1325194 at offset 2648493
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1322798 at offset 293
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1322703 at offset 388
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1322639 at offset 452
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1325302 at offset 1323191
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1325210 at offset 1323283
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1325150 at offset 1323343
Oct 31, 2018 03:01:48.495 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found mdia atom of size 1325094 at offset 2648593
Oct 31, 2018 03:01:48.496 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found minf atom of size 1325002 at offset 2648685
Oct 31, 2018 03:01:48.496 [0x7f61e2672d40] DEBUG - Mp4AtomParser: Found stbl atom of size 1324942 at offset 2648745
Oct 31, 2018 03:01:48.497 [0x7f61e2672d40] DEBUG - [MI]  * 879f491e63543c5e3c0e7387262728b0adc00283 [mp4 h264/aac] Duration: 5967295ms, 1920x848 (2.264151) 23.976fps, bitrate=2331kbps, audio channels=6, optimizedForStreaming=1 ("/media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4")
Oct 31, 2018 03:01:48.497 [0x7f61e2672d40] DEBUG - [MI] Chapters had generic titles, clearing.
Oct 31, 2018 03:01:48.497 [0x7f61e2672d40] DEBUG - [MI] Closing input file: "/media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4"
Oct 31, 2018 03:01:48.500 [0x7f61e2672d40] DEBUG - [FFMPEG] - Statistics: 4020014 bytes read, 2 seeks
Oct 31, 2018 03:01:48.501 [0x7f61e2672d40] DEBUG - Committing media stream changes for part 1606
Oct 31, 2018 03:01:48.515 [0x7f61e2672d40] DEBUG - Updating media item 1604, size=1739185994, metadata_item_id=1365
Oct 31, 2018 03:01:48.515 [0x7f61e2672d40] DEBUG - Updating part with ID=1606 [/media/NAS/Shared_Videos/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous/Shaun.of.the.Dead.2004.1080p.BluRay.x264.anoXmous_.mp4]
Oct 31, 2018 03:01:48.536 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1365&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:48.538 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1365&metadataType=1&state=-1&mediaState=analyzing
Oct 31, 2018 03:01:48.538 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1365&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:48.539 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1365&metadataType=1&state=-1&mediaState=thumbnailing
Oct 31, 2018 03:01:48.540 [0x7f61cf3ff700] DEBUG - HTTP requesting GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1365&metadataType=1&state=-1&mediaState=idle
Oct 31, 2018 03:01:48.541 [0x7f61cf3ff700] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/:/metadata/notify/changeItemState?librarySectionID=1&metadataItemID=1365&metadataType=1&state=-1&mediaState=idle
