amarok:       BEGIN: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State)
amarok:         [ContextBrowser] Rendering showCurrentTrack()
amarok:       END__: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State) - Took 0.11s
amarok:     END__: void EngineSubject::stateChangedNotify(Engine::State) - Took 0.15s
amarok:     BEGIN: virtual void ThreadWeaver::Thread::run()
amarok:       BEGIN: virtual bool CurrentTrackJob::doJob()
amarok:         BEGIN: void CurrentTrackJob::showHome()
amarok:         END__: void CurrentTrackJob::showHome() - Took 4.7s
amarok:       END__: virtual bool CurrentTrackJob::doJob() - Took 4.7s
amarok:     END__: virtual void ThreadWeaver::Thread::run() - Took 4.7s
amarok:     [ThreadWeaver] Job completed: CurrentTrackJob. Jobs pending: 0
amarok:     BEGIN: void EngineController::play(const MetaBundle&, uint)
amarok:       [controller] Loading URL: lastfm://user/dangle_wtf/neighbours
amarok:       [controller] Connecting to protocol: lastfm
amarok:       BEGIN: KURL LastFm::Controller::getNewProxy(QString)
amarok:       END__: KURL LastFm::Controller::getNewProxy(QString) - Took 8.6e-05s
amarok:       [controller] New URL is http://localhost:48210/theBeard.mp3
amarok:       In load http://localhost:48210/theBeard.mp3
amarok:       In canDecode http://localhost:48210/theBeard.mp3
amarok:       xfadeLength is 0
amarok:       BEGIN: void EngineSubject::stateChangedNotify(Engine::State)
amarok:         BEGIN: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State)
amarok:         END__: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State) - Took 2.3e-05s
amarok:       END__: void EngineSubject::stateChangedNotify(Engine::State) - Took 0.00016s
amarok:       In play
amarok:       BEGIN: void EngineSubject::stateChangedNotify(Engine::State)
CHILD 0 gets STOP
CHILD 1 gets STOP
CHILD 1 setURL for http://localhost:48210/theBeard.mp3,islocal=0,len=35
SETURL MASTER VOL: 0
in engine context, key is <LiveSuperBuffer>
in engine context, key is <TurboPushdown>
in engine context, key is <PerfectPlayTime>
in engine context, key is <BufferedPlayTime>
in engine context, key is <PerfPlayEntireClip>
in engine context, key is <ConnectionTimeout>
in engine context, key is <ServerTimeout>
in engine context, key is <CacheEnabled>
in engine context, key is <CacheFilename>
in engine context, key is <Authorization>
in engine context, key is <CacheMaxSize>
in engine context, key is <CacheDefaultTTL>
in engine context, key is <DefaultTTL>
in engine context, key is <CacheCutOffDate>
in engine context, key is <Bandwidth>
in engine context, key is <AllowAuthID>
in engine context, key is <HTTPProxyAutoConfig>
in engine context, key is <ProxyAutoConfig>
in engine context, key is <HTTPProxySupport>
in engine context, key is <CookiesEnabled>
in engine context, key is <CookiesEnabled>
in engine context, key is <CookiesPath>
in engine context, key is <UserSDKDataPath>
in engine context, key is <NetworkThreading>
setting initial NetworkTheading to value = 1
in engine context, key is <ThreadedDNS>
in engine context, key is <NoAsyncDNS>
in engine context, key is <MaxBandwidth>
in engine context, key is <LoadTest>
in engine context, key is <EnforceMaxBandwidth>
Master Volume is: 0
Volume is: 0
CHILD 1 gets START
START MASTER VOL: 0
amarok:         [virtual void amaroK::StatusBar::engineStateChanged(Engine::State, Engine::State)] Line: 135
amarok:         BEGIN: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State)
amarok:         END__: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State) - Took 0.002s
amarok:       END__: void EngineSubject::stateChangedNotify(Engine::State) - Took 0.017s
amarok:       BEGIN: void EngineSubject::newMetaDataNotify(const MetaBundle&, bool)
amarok:         [ContextBrowser] Rendering showCurrentTrack()
amarok:       END__: void EngineSubject::newMetaDataNotify(const MetaBundle&, bool) - Took 0.17s
amarok:     END__: void EngineController::play(const MetaBundle&, uint) - Took 0.19s
amarok:     BEGIN: virtual void LastFm::StreamProxy::newConnection(int)
amarok:       BEGIN: void LastFm::Server::accept(int)
amarok:       END__: void LastFm::Server::accept(int) - Took 0.00034s
amarok:     END__: virtual void LastFm::StreamProxy::newConnection(int) - Took 0.001s
amarok:     BEGIN: virtual void ThreadWeaver::Thread::run()
amarok:       BEGIN: virtual bool CurrentTrackJob::doJob()
amarok:       END__: virtual bool CurrentTrackJob::doJob() - Took 0.0047s
amarok:       [ThreadWeaver] Job completed: CurrentTrackJob. Jobs pending: 0
amarok:     END__: virtual void ThreadWeaver::Thread::run() - Took 0.085s
NO expansion of error message available
amarok:     Ok, finished playing the track
amarok:     [CollectionDB] track ended: lastfm://user/dangle_wtf/neighbours
CHILD 1 gets STOP
amarok:     In stop
amarok:     BEGIN: void EngineSubject::stateChangedNotify(Engine::State)
CHILD 0 gets STOP
CHILD 1 gets STOP
CHILD 1 gets STOP
amarok:       BEGIN: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State)
amarok:         [ContextBrowser] Rendering showCurrentTrack()
amarok:       END__: virtual void ContextBrowser::engineStateChanged(Engine::State, Engine::State) - Took 0.12s
amarok:     END__: void EngineSubject::stateChangedNotify(Engine::State) - Took 0.15s
amarok:     BEGIN: virtual void ThreadWeaver::Thread::run()
amarok:       BEGIN: virtual bool CurrentTrackJob::doJob()
amarok:         BEGIN: void CurrentTrackJob::showHome()
amarok:         END__: void CurrentTrackJob::showHome() - Took 6.9s
amarok:       END__: virtual bool CurrentTrackJob::doJob() - Took 6.9s
amarok:       [ThreadWeaver] Job completed: CurrentTrackJob. Jobs pending: 0
amarok:     END__: virtual void ThreadWeaver::Thread::run() - Took 6.9s