main debug: processing request item: magicsoul.ogg, node: Playlist, skip: 0
main debug: rebuilding array of current - root Playlist
main debug: rebuild done - 1 items, index 0
main debug: starting playback of new item
main debug: resyncing on magicsoul.ogg
main debug: magicsoul.ogg is at 0
main debug: creating new input thread
main debug: Creating an input for 'magicsoul.ogg'
main debug: requesting art for new input thread
main debug: using timeshift granularity of 50 MiB
main debug: using timeshift path: C:\Users\neila\AppData\Local\Temp
main debug: `
http://icecast-beta.timlradio.co.uk:80/magicsoul.ogg' gives access `http' demux `any' path `icecast-beta.timlradio.co.uk:80/magicsoul.ogg'
main debug: creating demux: access='http' demux='any' location='icecast-beta.timlradio.co.uk:80/magicsoul.ogg' file='\\icecast-beta.timlradio.co.uk:80\magicsoul.ogg'
main debug: looking for access_demux module matching "http": 15 candidates
main debug: no access_demux modules matched
main debug: creating access:
http://icecast-beta.timlradio.co.uk:80/magicsoul.ogg
main debug: (path: \\icecast-beta.timlradio.co.uk:80\magicsoul.ogg)
main debug: looking for access module matching "http": 26 candidates
main debug: looking for meta fetcher module matching "any": 1 candidates
lua debug: Trying Lua scripts in C:\Users\neila\AppData\Roaming\vlc\lua\meta\fetcher
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\fetcher
main debug: no meta fetcher modules matched
main debug: looking for art finder module matching "any": 2 candidates
lua debug: Trying Lua scripts in C:\Users\neila\AppData\Roaming\vlc\lua\meta\art
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\art
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
http debug: resolving icecast-beta.timlradio.co.uk ...
lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
lua debug: skipping script (unmatched scope) C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
main debug: no art finder modules matched
main debug: looking for meta fetcher module matching "any": 1 candidates
lua debug: Trying Lua scripts in C:\Users\neila\AppData\Roaming\vlc\lua\meta\fetcher
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\fetcher
main debug: no meta fetcher modules matched
main debug: looking for art finder module matching "any": 2 candidates
lua debug: Trying Lua scripts in C:\Users\neila\AppData\Roaming\vlc\lua\meta\art
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\art
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\00_musicbrainz.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\01_googleimage.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\02_frenchtv.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\art\03_lastfm.luac
http debug: outgoing request: GET /magicsoul.ogg HTTP/1.1 Host: icecast-beta.timlradio.co.uk:80 Accept: */* Accept-Language: en_GB User-Agent: VLC/3.0.3 LibVLC/3.0.3 Range: bytes=0-
main debug: no art finder modules matched
qt debug: IM: Setting an input
http debug: incoming response: HTTP/1.0 200 OK Content-Type: audio/ogg Date: Fri, 24 Aug 2018 09:21:54 GMT icy-name:Magic Soul icy-pub:0 icy-metadata:1 Server: Icecast 2.4.0-kh7 Cache-Control: no-cache, no-store Access-Control-Allow-Origin: * Access-Control-Allow-Headers: Origin, Accept, X-Requested-With, Content-Type Access-Control-Allow-Methods: GET, OPTIONS, HEAD Connection: Close Expires: Mon, 26 Jul 1997 05:00:00 GMT
main debug: no access modules matched
main debug: redirecting to: icyx://icecast-beta.timlradio.co.uk:80/magicsoul.ogg
main debug: creating access: icyx://icecast-beta.timlradio.co.uk:80/magicsoul.ogg
main debug: (path: \\icecast-beta.timlradio.co.uk:80\magicsoul.ogg)
main debug: looking for access module matching "icyx": 26 candidates
http debug: querying proxy for icyx://icecast-beta.timlradio.co.uk:80/magicsoul.ogg
http debug: no proxy
http debug: http: server='icecast-beta.timlradio.co.uk' port=80 file='/magicsoul.ogg'
main debug: net: connecting to icecast-beta.timlradio.co.uk port 80
main debug: connection succeeded (socket = 1812)
http debug: sending request: GET /magicsoul.ogg HTTP/1.0 Host: icecast-beta.timlradio.co.uk User-Agent: VLC/3.0.3 LibVLC/3.0.3 Icy-MetaData: 1
http debug: HTTP answer code 200
http debug: Content-Type: audio/ogg
http debug: Icy-Name: Magic Soul
http debug: Meta-Info: icy-pub: 0
http debug: Meta-Info: icy-metadata: 1
http debug: Server: Icecast 2.4.0-kh7
http debug: auto re-connect enabled
main debug: using access module "http"
main debug: looking for stream_filter module matching "prefetch,cache_read": 24 candidates
prefetch debug: using 16777216 bytes buffer, 16384 bytes read
main debug: using stream_filter module "prefetch"
main debug: looking for stream_filter module matching "any": 24 candidates
lua debug: Trying Lua scripts in C:\Users\neila\AppData\Roaming\vlc\lua\playlist
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\playlist
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\anevia_streams.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\anevia_xml.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\appletrailers.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\bbc_co_uk.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\cue.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\dailymotion.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\jamendo.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\koreus.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\liveleak.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\newgrounds.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\rockbox_fm_presets.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\soundcloud.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\twitch.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\vimeo.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\vocaroo.luac
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\playlist\youtube.luac
main debug: no stream_filter modules matched
main debug: looking for stream_directory module matching "any": 1 candidates
main debug: no stream_directory modules matched
main debug: attachment of directory-extractor failed for icyx://icecast-beta.timlradio.co.uk:80/magicsoul.ogg
main debug: looking for stream_filter module matching "record": 24 candidates
main debug: using stream_filter module "record"
main debug: creating demux: access='http' demux='any' location='icecast-beta.timlradio.co.uk:80/magicsoul.ogg' file='\\icecast-beta.timlradio.co.uk:80\magicsoul.ogg'
main debug: looking for demux module matching "ogg": 55 candidates
ogg debug: File length is 0 bytes
ogg debug: found FLAC header version 1.0 (1 header packets)
ogg debug: FLAC header, channels: 2, rate: 48000
ogg debug: beginning of a group of logical streams
main debug: using demux module "ogg"
main debug: looking for meta reader module matching "any": 2 candidates
lua debug: Trying Lua scripts in C:\Users\neila\AppData\Roaming\vlc\lua\meta\reader
lua debug: Trying Lua scripts in C:\Program Files\VideoLAN\VLC\lua\meta\reader
lua debug: Trying Lua playlist script C:\Program Files\VideoLAN\VLC\lua\meta\reader\filename.luac
main debug: no meta reader modules matched
main debug: `
http://icecast-beta.timlradio.co.uk:80/magicsoul.ogg' successfully opened
main debug: selecting program id=0
main debug: looking for packetizer module matching "any": 24 candidates
main debug: using packetizer module "flac"
main debug: looking for audio decoder module matching "any": 23 candidates
main debug: using audio decoder module "flac"
ogg warning: Consider increasing access caching variable from 1000 to >32370912
main debug: Buffering 0%
main debug: Buffering 28%
main debug: restarting module due to input format change
main debug: removing module "flac"
main debug: looking for audio decoder module matching "any": 23 candidates
main debug: using audio decoder module "flac"
flac debug: decode STREAMINFO
flac debug: channels:2 samplerate:48000 bitspersamples:24
flac debug: STREAMINFO decoded
flac warning: an error in the stream caused the decoder to lose synchronization.
main debug: Buffering 48%
main debug: reusing audio output
main debug: looking for aout stream module matching "any": 2 candidates
main debug: Buffering 67%
main debug: Buffering 86%
main debug: Stream buffering done (1056 ms in 0 ms)
wasapi debug: buffer size : 96000 frames
wasapi debug: maximum latency: 000 ns
wasapi debug: default period : 10000000 ns
wasapi debug: minimum period : 3000000 ns
main debug: using aout stream module "wasapi"
main debug: output 'f32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: looking for audio volume module matching "any": 2 candidates
main debug: using audio volume module "float_mixer"
main debug: input 's32l' 48000 Hz Stereo frame=1 samples/8 bytes
main debug: looking for audio filter module matching "scaletempo": 16 candidates
scaletempo debug: format: 48000 rate, 2 nch, 4 bps, fl32
scaletempo debug: params: 30 stride, 0.200 overlap, 14 search
scaletempo debug: 1.000 scale, 1440.000 stride_in, 1440 stride_out, 1152 standing, 288 overlap, 672 search, 2400 queue, fl32 mode
main debug: using audio filter module "scaletempo"
main debug: conversion: 's32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: looking for audio converter module matching "any": 8 candidates
audio_format debug: s32l->f32l, bits per sample: 32->32
main debug: using audio converter module "audio_format"
main debug: conversion pipeline complete
main debug: conversion: 'f32l'->'f32l' 48000 Hz->48000 Hz Stereo->Stereo
main debug: conversion pipeline complete
main debug: looking for audio resampler module matching "any": 3 candidates
main debug: using audio resampler module "samplerate"
main debug: Decoder wait done in 327 ms
main debug: inserting 480 zeroes
mmdevice debug: state changed: 1
qt debug: Using a general info windows
main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1000 ms)
main debug: ES_OUT_RESET_PCR called
main debug: Buffering 0%
main debug: Buffering 28%
main debug: Buffering 57%
main debug: Buffering 86%
main debug: Stream buffering done (1152 ms in 1251 ms)
main debug: Decoder wait done in 0 ms
main warning: buffer too late (-374000 us): dropped
mmdevice debug: state changed: 0
wasapi debug: reset
main warning: buffer too late (-278000 us): dropped
main warning: buffer too late (-182000 us): dropped
main debug: inserting 240 zeroes
mmdevice debug: state changed: 1
main warning: buffer too late (-132000 us): dropped
main debug: playback too late (39996): flushing buffers
mmdevice debug: state changed: 0
wasapi debug: reset
mmdevice debug: state changed: 1
main error: ES_OUT_SET_(GROUP_)PCR is called too late (pts_delay increased to 1101 ms)
main debug: ES_OUT_RESET_PCR called
main debug: Buffering 0%
main debug: Buffering 34%
main debug: Buffering 61%
main debug: Buffering 87%
main debug: Stream buffering done (1248 ms in 3354 ms)
main debug: Decoder wait done in 0 ms
main warning: buffer too late (-470000 us): dropped
mmdevice debug: state changed: 0
wasapi debug: reset
main warning: buffer too late (-187000 us): dropped
main debug: inserting 0 zeroes
mmdevice debug: state changed: 1