Nov 24, 2018 02:06:04.236 [0x7fed98e8a710] INFO - Plex Media Scanner v1.13.9.5456-ecd600442 - ubuntu PC x86_64 - build: linux-ubuntu-x86_64 - GMT -05:00
Nov 24, 2018 02:06:04.236 [0x7fed98e8a710] INFO - Linux version: 3.10.71 (#1 SMP PREEMPT Thu Apr 16 22:06:01 CST 2015), language: en-US
Nov 24, 2018 02:06:04.237 [0x7fed98e8a710] INFO - Processor         Intel(R) Atom(TM) CPU D2550   @ 1.86GHz
Nov 24, 2018 02:06:04.237 [0x7fed98e8a710] INFO - /raid0/data/module/Plex/sys/Plex Media Scanner --analyze --item 50746,50642,50646,50952,50653,50715,50721,50716,50958,50962 --log-file-suffix  Analysis
Nov 24, 2018 02:06:04.398 [0x7feda3f447e0] DEBUG - Opening 20 database sessions to library (com.plexapp.plugins.library), SQLite 3.13.0, threadsafe=1
Nov 24, 2018 02:06:05.023 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50746 (Shores Of California): 47999
Nov 24, 2018 02:06:05.029 [0x7feda3f447e0] DEBUG - [ID 48649] Media part analysis: /raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a
Nov 24, 2018 02:06:05.029 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a"
Nov 24, 2018 02:06:05.030 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a' for reading
Nov 24, 2018 02:06:05.031 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.032 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.033 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.033 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.053 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 51240 bytes read:65536 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.063 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.064 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.064 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.064 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.065 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 51247 bytes read:65536 seeks:0 frames:1
Nov 24, 2018 02:06:05.065 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.065 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.065 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 40502 at offset 32
Nov 24, 2018 02:06:05.065 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 39397 at offset 148
Nov 24, 2018 02:06:05.065 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 39297 at offset 248
Nov 24, 2018 02:06:05.066 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 39223 at offset 322
Nov 24, 2018 02:06:05.066 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 39163 at offset 382
Nov 24, 2018 02:06:05.066 [0x7feda3f447e0] DEBUG - [MI]  * d415709c084dcee8241815ea58b6e056b0afd2d5 [mp4 /aac] Duration: 215829ms, 0x0 (0.000000) 0.000fps, bitrate=129kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a")
Nov 24, 2018 02:06:05.069 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.072 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.072 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.080 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.081 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (Shores Of California) with ID 50746
Nov 24, 2018 02:06:05.132 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a"
Nov 24, 2018 02:06:05.133 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 0 seeks
Nov 24, 2018 02:06:05.138 [0x7feda3f447e0] DEBUG - Updating media item 47999, size=3507223, metadata_item_id=50746
Nov 24, 2018 02:06:05.140 [0x7feda3f447e0] DEBUG - Updating part with ID=48649 [/raid/NAS_Public/Music/The Dresden Dolls/2006 - Yes, Virginia/1.09 - Shores Of California.m4a]
Nov 24, 2018 02:06:05.171 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50642 ((Love Is a) Blind Ambition): 47903
Nov 24, 2018 02:06:05.175 [0x7feda3f447e0] DEBUG - [ID 48553] Media part analysis: /raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a
Nov 24, 2018 02:06:05.176 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a"
Nov 24, 2018 02:06:05.176 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a' for reading
Nov 24, 2018 02:06:05.176 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.177 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.177 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.177 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.202 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 72026 bytes read:98429 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.204 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.204 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.204 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 72033 bytes read:98429 seeks:0 frames:1
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 69690 at offset 32
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 68629 at offset 148
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 68529 at offset 248
Nov 24, 2018 02:06:05.205 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 68455 at offset 322
Nov 24, 2018 02:06:05.206 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 68395 at offset 382
Nov 24, 2018 02:06:05.206 [0x7feda3f447e0] DEBUG - [MI]  * 65e78b12e5c16a247e47423c3bcaab21514de01e [mp4 /aac] Duration: 377812ms, 0x0 (0.000000) 0.000fps, bitrate=129kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a")
Nov 24, 2018 02:06:05.208 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.210 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.210 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.216 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.217 [0x7feda3f447e0] DEBUG - Updating metadata item (save) ((Love Is a) Blind Ambition) with ID 50642
Nov 24, 2018 02:06:05.225 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a"
Nov 24, 2018 02:06:05.226 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 98429 bytes read, 0 seeks
Nov 24, 2018 02:06:05.231 [0x7feda3f447e0] DEBUG - Updating media item 47903, size=6092816, metadata_item_id=50642
Nov 24, 2018 02:06:05.232 [0x7feda3f447e0] DEBUG - Updating part with ID=48553 [/raid/NAS_Public/Music/Concrete Blonde/1993 - Mexican Moon/1.12 - (Love Is a) Blind Ambition.m4a]
Nov 24, 2018 02:06:05.255 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50646 (The Sky is a Poisonous Garden): 47906
Nov 24, 2018 02:06:05.260 [0x7feda3f447e0] DEBUG - [ID 48556] Media part analysis: /raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a
Nov 24, 2018 02:06:05.260 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a"
Nov 24, 2018 02:06:05.260 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a' for reading
Nov 24, 2018 02:06:05.260 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.261 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.261 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.261 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.263 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 32166 bytes read:32768 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.265 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.265 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.265 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.265 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.265 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 32173 bytes read:32768 seeks:0 frames:1
Nov 24, 2018 02:06:05.265 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.266 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.266 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 29836 at offset 32
Nov 24, 2018 02:06:05.266 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 28769 at offset 148
Nov 24, 2018 02:06:05.266 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 28669 at offset 248
Nov 24, 2018 02:06:05.266 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 28595 at offset 322
Nov 24, 2018 02:06:05.266 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 28535 at offset 382
Nov 24, 2018 02:06:05.267 [0x7feda3f447e0] DEBUG - [MI]  * 61ccb906dd87ed7a9d5d80844d69de4a955f79b3 [mp4 /aac] Duration: 156944ms, 0x0 (0.000000) 0.000fps, bitrate=128kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a")
Nov 24, 2018 02:06:05.269 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.271 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.271 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.276 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.277 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (The Sky is a Poisonous Garden) with ID 50646
Nov 24, 2018 02:06:05.301 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a"
Nov 24, 2018 02:06:05.302 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 32768 bytes read, 0 seeks
Nov 24, 2018 02:06:05.307 [0x7feda3f447e0] DEBUG - Updating media item 47906, size=2513630, metadata_item_id=50646
Nov 24, 2018 02:06:05.308 [0x7feda3f447e0] DEBUG - Updating part with ID=48556 [/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.02 - The Sky is a Poisonous Garden.m4a]
Nov 24, 2018 02:06:05.337 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50952 (Cry, Cry, Cry): 48183
Nov 24, 2018 02:06:05.342 [0x7feda3f447e0] DEBUG - [ID 48850] Media part analysis: /raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a
Nov 24, 2018 02:06:05.342 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a"
Nov 24, 2018 02:06:05.342 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a' for reading
Nov 24, 2018 02:06:05.342 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.355 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.355 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.356 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.360 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 51240 bytes read:65536 seeks:1 nb_streams:1
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 51247 bytes read:65536 seeks:1 frames:1
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.362 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.363 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 27593 at offset 32
Nov 24, 2018 02:06:05.363 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 26549 at offset 148
Nov 24, 2018 02:06:05.363 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 26449 at offset 248
Nov 24, 2018 02:06:05.363 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 26375 at offset 322
Nov 24, 2018 02:06:05.363 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 26315 at offset 382
Nov 24, 2018 02:06:05.363 [0x7feda3f447e0] DEBUG - [MI]  * 9c0b944f29ff510f2d295f521c9d6867f9f857af [mp4 /aac] Duration: 144637ms, 0x0 (0.000000) 0.000fps, bitrate=129kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a")
Nov 24, 2018 02:06:05.366 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.367 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.367 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.373 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.374 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (Cry, Cry, Cry) with ID 50952
Nov 24, 2018 02:06:05.391 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a"
Nov 24, 2018 02:06:05.391 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 1 seeks
Nov 24, 2018 02:06:05.396 [0x7feda3f447e0] DEBUG - Updating media item 48183, size=2342173, metadata_item_id=50952
Nov 24, 2018 02:06:05.397 [0x7feda3f447e0] DEBUG - Updating part with ID=48850 [/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.03 - Cry, Cry, Cry.m4a]
Nov 24, 2018 02:06:05.411 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50653 (Joey): 47913
Nov 24, 2018 02:06:05.416 [0x7feda3f447e0] DEBUG - [ID 48563] Media part analysis: /raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a
Nov 24, 2018 02:06:05.416 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a"
Nov 24, 2018 02:06:05.416 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a' for reading
Nov 24, 2018 02:06:05.417 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.417 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.418 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.418 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.430 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 48478 bytes read:65536 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.431 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.432 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.432 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.432 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.432 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 48485 bytes read:65536 seeks:0 frames:1
Nov 24, 2018 02:06:05.432 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.433 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.433 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 46098 at offset 32
Nov 24, 2018 02:06:05.433 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 45081 at offset 148
Nov 24, 2018 02:06:05.433 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 44981 at offset 248
Nov 24, 2018 02:06:05.433 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 44907 at offset 322
Nov 24, 2018 02:06:05.433 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 44847 at offset 382
Nov 24, 2018 02:06:05.437 [0x7feda3f447e0] DEBUG - [MI]  * cde9613f6c7755564273dda32604969daaef7998 [mp4 /aac] Duration: 247316ms, 0x0 (0.000000) 0.000fps, bitrate=128kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a")
Nov 24, 2018 02:06:05.440 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.442 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.442 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.448 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.450 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (Joey) with ID 50653
Nov 24, 2018 02:06:05.462 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a"
Nov 24, 2018 02:06:05.463 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 0 seeks
Nov 24, 2018 02:06:05.469 [0x7feda3f447e0] DEBUG - Updating media item 47913, size=3977511, metadata_item_id=50653
Nov 24, 2018 02:06:05.470 [0x7feda3f447e0] DEBUG - Updating part with ID=48563 [/raid/NAS_Public/Music/Concrete Blonde/1990 - Bloodletting/1.09 - Joey.m4a]
Nov 24, 2018 02:06:05.495 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50715 (Tokyo Witch): 47972
Nov 24, 2018 02:06:05.500 [0x7feda3f447e0] DEBUG - [ID 48622] Media part analysis: /raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a
Nov 24, 2018 02:06:05.500 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a"
Nov 24, 2018 02:06:05.501 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a' for reading
Nov 24, 2018 02:06:05.501 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.502 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.502 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.502 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.516 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 44650 bytes read:65536 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.517 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.518 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.518 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.518 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.518 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 44657 bytes read:65536 seeks:0 frames:1
Nov 24, 2018 02:06:05.518 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.519 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.519 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 42330 at offset 32
Nov 24, 2018 02:06:05.519 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 41253 at offset 148
Nov 24, 2018 02:06:05.519 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 41153 at offset 248
Nov 24, 2018 02:06:05.519 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 41079 at offset 322
Nov 24, 2018 02:06:05.519 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 41019 at offset 382
Nov 24, 2018 02:06:05.520 [0x7feda3f447e0] DEBUG - [MI]  * 217a4293dd57f32080af99350a4f55b4b60aa0e0 [mp4 /aac] Duration: 226116ms, 0x0 (0.000000) 0.000fps, bitrate=127kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a")
Nov 24, 2018 02:06:05.522 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.524 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.524 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.529 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.530 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (Tokyo Witch) with ID 50715
Nov 24, 2018 02:06:05.538 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a"
Nov 24, 2018 02:06:05.539 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 0 seeks
Nov 24, 2018 02:06:05.544 [0x7feda3f447e0] DEBUG - Updating media item 47972, size=3595578, metadata_item_id=50715
Nov 24, 2018 02:06:05.545 [0x7feda3f447e0] DEBUG - Updating part with ID=48622 [/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.02 - Tokyo Witch.m4a]
Nov 24, 2018 02:06:05.567 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50721 (House on the Hill): 47978
Nov 24, 2018 02:06:05.572 [0x7feda3f447e0] DEBUG - [ID 48628] Media part analysis: /raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a
Nov 24, 2018 02:06:05.572 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a"
Nov 24, 2018 02:06:05.572 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a' for reading
Nov 24, 2018 02:06:05.572 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.573 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.573 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.574 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.589 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 39678 bytes read:65536 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.590 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 39685 bytes read:65536 seeks:0 frames:1
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.591 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 37370 at offset 32
Nov 24, 2018 02:06:05.592 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 36281 at offset 148
Nov 24, 2018 02:06:05.592 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 36181 at offset 248
Nov 24, 2018 02:06:05.592 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 36107 at offset 322
Nov 24, 2018 02:06:05.592 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 36047 at offset 382
Nov 24, 2018 02:06:05.592 [0x7feda3f447e0] DEBUG - [MI]  * ee7b82e1ee9f95846aa17371ed575b1bfa3090fc [mp4 /aac] Duration: 198554ms, 0x0 (0.000000) 0.000fps, bitrate=126kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a")
Nov 24, 2018 02:06:05.595 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.596 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.597 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.602 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.603 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (House on the Hill) with ID 50721
Nov 24, 2018 02:06:05.611 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a"
Nov 24, 2018 02:06:05.611 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 0 seeks
Nov 24, 2018 02:06:05.617 [0x7feda3f447e0] DEBUG - Updating media item 47978, size=3146280, metadata_item_id=50721
Nov 24, 2018 02:06:05.618 [0x7feda3f447e0] DEBUG - Updating part with ID=48628 [/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.08 - House on the Hill.m4a]
Nov 24, 2018 02:06:05.645 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50716 (Apple Orchard): 47973
Nov 24, 2018 02:06:05.650 [0x7feda3f447e0] DEBUG - [ID 48623] Media part analysis: /raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a
Nov 24, 2018 02:06:05.650 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a"
Nov 24, 2018 02:06:05.650 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a' for reading
Nov 24, 2018 02:06:05.650 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.651 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.651 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.651 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.669 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 53550 bytes read:65536 seeks:0 nb_streams:1
Nov 24, 2018 02:06:05.670 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 53557 bytes read:65536 seeks:0 frames:1
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.671 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 51234 at offset 32
Nov 24, 2018 02:06:05.672 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 50153 at offset 148
Nov 24, 2018 02:06:05.672 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 50053 at offset 248
Nov 24, 2018 02:06:05.672 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 49979 at offset 322
Nov 24, 2018 02:06:05.672 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 49919 at offset 382
Nov 24, 2018 02:06:05.672 [0x7feda3f447e0] DEBUG - [MI]  * fcab8ce4a952670211005f1ff4dad94f2ee8eb75 [mp4 /aac] Duration: 275435ms, 0x0 (0.000000) 0.000fps, bitrate=127kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a")
Nov 24, 2018 02:06:05.675 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.676 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.676 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.681 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.682 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (Apple Orchard) with ID 50716
Nov 24, 2018 02:06:05.690 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a"
Nov 24, 2018 02:06:05.691 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 0 seeks
Nov 24, 2018 02:06:05.696 [0x7feda3f447e0] DEBUG - Updating media item 47973, size=4396551, metadata_item_id=50716
Nov 24, 2018 02:06:05.697 [0x7feda3f447e0] DEBUG - Updating part with ID=48623 [/raid/NAS_Public/Music/Beach House/2006 - Beach House/1.03 - Apple Orchard.m4a]
Nov 24, 2018 02:06:05.723 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50958 (So Doggone Lonesome): 48189
Nov 24, 2018 02:06:05.728 [0x7feda3f447e0] DEBUG - [ID 48856] Media part analysis: /raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a
Nov 24, 2018 02:06:05.728 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a"
Nov 24, 2018 02:06:05.728 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a' for reading
Nov 24, 2018 02:06:05.728 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.729 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.729 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.729 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.748 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 51240 bytes read:65536 seeks:1 nb_streams:1
Nov 24, 2018 02:06:05.750 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.750 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.750 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.750 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 51247 bytes read:65536 seeks:1 frames:1
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 29781 at offset 32
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 28725 at offset 148
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 28625 at offset 248
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 28551 at offset 322
Nov 24, 2018 02:06:05.751 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 28491 at offset 382
Nov 24, 2018 02:06:05.752 [0x7feda3f447e0] DEBUG - [MI]  * 0e529139523be3db1fd82248bb8409c55434c22a [mp4 /aac] Duration: 156688ms, 0x0 (0.000000) 0.000fps, bitrate=129kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a")
Nov 24, 2018 02:06:05.754 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.755 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.756 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.761 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.762 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (So Doggone Lonesome) with ID 50958
Nov 24, 2018 02:06:05.770 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a"
Nov 24, 2018 02:06:05.770 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 1 seeks
Nov 24, 2018 02:06:05.776 [0x7feda3f447e0] DEBUG - Updating media item 48189, size=2535238, metadata_item_id=50958
Nov 24, 2018 02:06:05.777 [0x7feda3f447e0] DEBUG - Updating part with ID=48856 [/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.09 - So Doggone Lonesome.m4a]
Nov 24, 2018 02:06:05.800 [0x7feda3f447e0] DEBUG - Analyzing media parts for item 50962 (Train Of Love): 48193
Nov 24, 2018 02:06:05.805 [0x7feda3f447e0] DEBUG - [ID 48860] Media part analysis: /raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a
Nov 24, 2018 02:06:05.805 [0x7feda3f447e0] DEBUG - [MI] Opening input file: "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a"
Nov 24, 2018 02:06:05.805 [0x7feda3f447e0] DEBUG - [FFMPEG] - Opening '/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a' for reading
Nov 24, 2018 02:06:05.805 [0x7feda3f447e0] DEBUG - [FFMPEG] - Setting default whitelist 'file,crypto'
Nov 24, 2018 02:06:05.819 [0x7feda3f447e0] DEBUG - [FFMPEG] - Format mov,mp4,m4a,3gp,3g2,mj2 probed with size=2048 and score=100
Nov 24, 2018 02:06:05.820 [0x7feda3f447e0] DEBUG - [FFMPEG] - ISO: File Type Major Brand: M4A 
Nov 24, 2018 02:06:05.820 [0x7feda3f447e0] DEBUG - [FFMPEG] - Unknown dref type 0x206c7275 size 12
Nov 24, 2018 02:06:05.821 [0x7feda3f447e0] DEBUG - [FFMPEG] - Before avformat_find_stream_info() pos: 51240 bytes read:65536 seeks:1 nb_streams:1
Nov 24, 2018 02:06:05.823 [0x7feda3f447e0] DEBUG - [FFMPEG] - demuxer injecting skip 2112 / discard 0
Nov 24, 2018 02:06:05.823 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip 2112 / discard 0 samples due to side data
Nov 24, 2018 02:06:05.823 [0x7feda3f447e0] DEBUG - [FFMPEG] - skip whole frame, skip left: 1088
Nov 24, 2018 02:06:05.823 [0x7feda3f447e0] DEBUG - [FFMPEG] - All info found
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - [FFMPEG] - After avformat_find_stream_info() pos: 51247 bytes read:65536 seeks:1 frames:1
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - [MI] Opening "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a" for MP4 atom parsing
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Skipping ftyp atom of size 32 at offset 0
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found moov atom of size 27437 at offset 32
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found trak atom of size 26393 at offset 148
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found mdia atom of size 26293 at offset 248
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found minf atom of size 26219 at offset 322
Nov 24, 2018 02:06:05.824 [0x7feda3f447e0] DEBUG - Mp4AtomParser: Found stbl atom of size 26159 at offset 382
Nov 24, 2018 02:06:05.825 [0x7feda3f447e0] DEBUG - [MI]  * 5ff1a22eb1273f95dfd54f3abf0a22866ba49964 [mp4 /aac] Duration: 143848ms, 0x0 (0.000000) 0.000fps, bitrate=129kbps, audio channels=2, optimizedForStreaming=1 ("/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a")
Nov 24, 2018 02:06:05.827 [0x7feda3f447e0] DEBUG - [MI] Importing 1 media chapters.
Nov 24, 2018 02:06:05.828 [0x7feda3f447e0] DEBUG - Downloading document http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.829 [0x7feda3f447e0] DEBUG - HTTP requesting GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.834 [0x7feda3f447e0] DEBUG - HTTP 200 response from GET http://127.0.0.1:32400/library/changestamp
Nov 24, 2018 02:06:05.835 [0x7feda3f447e0] DEBUG - Updating metadata item (save) (Train Of Love) with ID 50962
Nov 24, 2018 02:06:06.225 [0x7feda3f447e0] DEBUG - [MI] Closing input file: "/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a"
Nov 24, 2018 02:06:06.225 [0x7feda3f447e0] DEBUG - [FFMPEG] - Statistics: 65536 bytes read, 1 seeks
Nov 24, 2018 02:06:06.233 [0x7feda3f447e0] DEBUG - Updating media item 48193, size=2329519, metadata_item_id=50962
Nov 24, 2018 02:06:06.234 [0x7feda3f447e0] DEBUG - Updating part with ID=48860 [/raid/NAS_Public/Music/Johnny Cash/2006 - Golden Legends/1.13 - Train Of Love.m4a]
