Bug 228262

Summary: [OS X] Playing leads to 100% CPU usage on OSX
Product: [Applications] amarok Reporter: alfonso.acosta
Component: generalAssignee: Amarok Developers <amarok-bugs-dist>
Status: RESOLVED NOT A BUG    
Severity: normal CC: alver, lfranchi, michael
Priority: NOR    
Version: 2.3-GIT   
Target Milestone: ---   
Platform: MacPorts   
OS: macOS   
Latest Commit: Version Fixed In:
Sentry Crash Report:
Attachments: debug info

Description alfonso.acosta 2010-02-24 02:09:54 UTC
Version:           2.2-GIT (Feb 24 2010) (using KDE 4.4.0)
Compiler:          i686-apple-darwin9-g++-4.0.1 
OS:                OS X
Installed from:    Compiled From Sources

I compiled amarok from source today (from the git repository).

I was really surprised to see that it takes 100% of the CPU when playing music (pausing results in just a 2%). Do you have suggestions on what is happening? Is there something I can do to identify what's the problem?


All amarok dependencies (including kde) were compiled with macports (based on the dependencies of the amarok-devel port http://trac.macports.org/browser/trunk/dports/kde/amarok-devel/Portfile)
Comment 1 Myriam Schweingruber 2010-02-24 13:06:18 UTC
We would need an output of some sort. Leo, what is needed on Mac to identify the problem?
Comment 2 alfonso.acosta 2010-02-27 12:52:38 UTC
I got a 13min play trace with Instruments. (Had to use megaupload due to the file size). 

http://www.megaupload.com/?d=TBPYCWPE
Comment 3 Leo Franchi 2010-02-27 17:20:30 UTC
hmm megaupload says file is not available.

feel free to email to lfranchi@kde.org, i'll check it out in Instruments when I boot into OS X next. i'll also send it to max, who is on os x full-time.
Comment 4 Myriam Schweingruber 2010-06-07 23:54:08 UTC
Any news on this, Alfonso or Leo?
Comment 5 Myriam Schweingruber 2010-06-24 10:47:20 UTC
*** Bug 235244 has been marked as a duplicate of this bug. ***
Comment 6 Myriam Schweingruber 2010-08-15 11:18:38 UTC
Closing for lack of feedback. Feel free to reopen if you can reproduce this with the latest Amarok build.
Comment 7 Michael 2010-09-17 08:00:24 UTC
Created attachment 51741 [details]
debug info
Comment 8 Michael 2010-09-17 08:01:18 UTC
still reproducable in amarok 2.3.1, I have amarok built for mac again so can help contribute to fixing this bug
Comment 9 Myriam Schweingruber 2010-09-17 12:02:05 UTC
Debug info from comment #7:

amarok: BEGIN: void ScriptManager::updateAllScripts() 
amarok:   [ScriptManager] ScriptUpdater: Skipping update check 
amarok:   BEGIN: bool ScriptManager::loadScript(const QString&) 
amarok:     [ScriptManager] script info: "Librivox.org"   "1.0"   "Scriptable Service"   "Amarok2.0" 
amarok:   END__: bool ScriptManager::loadScript(const QString&) - Took 0.0028s 
amarok:   BEGIN: bool ScriptManager::loadScript(const QString&) 
amarok:     [ScriptManager] script info: "Lyricwiki"   ".2"   "Lyrics"   "Amarok2.0" 
amarok:   END__: bool ScriptManager::loadScript(const QString&) - Took 0.0016s 
amarok:   BEGIN: bool ScriptManager::loadScript(const QString&) 
amarok:     [ScriptManager] script info: "Cool Streams"   "1.0"   "Scriptable Service"   "Amarok2.0" 
amarok:   END__: bool ScriptManager::loadScript(const QString&) - Took 0.0015s 
amarok:   BEGIN: bool ScriptManager::loadScript(const QString&) 
amarok:     [ScriptManager] script info: "Amarok Script Console"   "1.0"   "Generic"   "Amarok2.0" 
amarok:   END__: bool ScriptManager::loadScript(const QString&) - Took 0.0016s 
amarok:   BEGIN: void ScriptManager::findScripts() 
amarok:     BEGIN: void ScriptSelector::addScripts(const QList<KPluginInfo>&, KPluginSelector::PluginLoadMethod, const QString&, const QString&, const KSharedPtr<KSharedConfig>&) 
amarok(76238)/kdecore (KPluginInfo) KPluginInfo::kcmServices: found  0  offers for  "Amarok Script Console"
amarok:     END__: void ScriptSelector::addScripts(const QList<KPluginInfo>&, KPluginSelector::PluginLoadMethod, const QString&, const QString&, const KSharedPtr<KSharedConfig>&) - Took 0.002s 
amarok:     BEGIN: void ScriptSelector::addScripts(const QList<KPluginInfo>&, KPluginSelector::PluginLoadMethod, const QString&, const QString&, const KSharedPtr<KSharedConfig>&) 
amarok(76238)/kdecore (KPluginInfo) KPluginInfo::kcmServices: found  0  offers for  "LyricWiki"
amarok:     END__: void ScriptSelector::addScripts(const QList<KPluginInfo>&, KPluginSelector::PluginLoadMethod, const QString&, const QString&, const KSharedPtr<KSharedConfig>&) - Took 0.0015s 
amarok:     BEGIN: void ScriptSelector::addScripts(const QList<KPluginInfo>&, KPluginSelector::PluginLoadMethod, const QString&, const QString&, const KSharedPtr<KSharedConfig>&) 
amarok(76238)/kdecore (KPluginInfo) KPluginInfo::kcmServices: found  0  offers for  "Cool Streams"
amarok(76238)/kdecore (KPluginInfo) KPluginInfo::kcmServices: found  0  offers for  "Librivox.org"
amarok:     END__: void ScriptSelector::addScripts(const QList<KPluginInfo>&, KPluginSelector::PluginLoadMethod, const QString&, const QString&, const KSharedPtr<KSharedConfig>&) - Took 0.0031s 
amarok:     BEGIN: void ScriptManager::slotConfigChanged(bool) 
amarok:       BEGIN: void ScriptManager::slotConfigChanged(bool) 
amarok:       END__: void ScriptManager::slotConfigChanged(bool) - Took 4.7e-05s 
amarok:       BEGIN: bool ScriptManager::slotRunScript(QString, bool) 
amarok:         BEGIN: void ScriptManager::startScriptEngine(QString) 
amarok:           BEGIN: ScriptableServiceScript::ScriptableServiceScript(QScriptEngine*) 
amarok:           END__: ScriptableServiceScript::ScriptableServiceScript(QScriptEngine*) - Took 8.5e-05s 
amarok:           BEGIN: Downloader::Downloader(QScriptEngine*) 
amarok:           END__: Downloader::Downloader(QScriptEngine*) - Took 6.1e-05s 
amarok:         END__: void ScriptManager::startScriptEngine(QString) - Took 0.001s 
amarok:         BEGIN: static QScriptValue ScriptableServiceScript::ScriptableServiceScript_prototype_ctor(QScriptContext*, QScriptEngine*) 
amarok:           BEGIN: bool ScriptableServiceManager::initService(const QString&, int, const QString&, const QString&, bool) 
amarok:              initializing scripted service:  "Cool Streams" 
amarok:             BEGIN: ServiceBase::ServiceBase(const QString&, ServiceFactory*, bool, const QString&) 
amarok:             END__: ServiceBase::ServiceBase(const QString&, ServiceFactory*, bool, const QString&) - Took 0.0063s 
amarok:             BEGIN: ScriptableService::ScriptableService(const QString&) 
amarok:                creating ScriptableService  "Cool Streams" 
amarok:             END__: ScriptableService::ScriptableService(const QString&) - Took 6.3e-05s 
amarok:             BEGIN: void ScriptableService::init(int, const QString&, bool) 
amarok:               BEGIN: Collections::ScriptableServiceCollection::ScriptableServiceCollection(const QString&) 
amarok:               END__: Collections::ScriptableServiceCollection::ScriptableServiceCollection(const QString&) - Took 4e-05s 
amarok:             END__: void ScriptableService::init(int, const QString&, bool) - Took 0.00015s 
amarok:              emitting scripted service  "Cool Streams" 
amarok:             BEGIN: void ServiceBrowser::addService(ServiceBase*) 
amarok:             END__: void ServiceBrowser::addService(ServiceBase*) - Took 0.00013s 
amarok:           END__: bool ScriptableServiceManager::initService(const QString&, int, const QString&, const QString&, bool) - Took 0.021s 
amarok:         END__: static QScriptValue ScriptableServiceScript::ScriptableServiceScript_prototype_ctor(QScriptContext*, QScriptEngine*) - Took 0.021s 
amarok:         BEGIN: void ScriptableServiceScript::slotCustomize(const QString&) 
amarok:         END__: void ScriptableServiceScript::slotCustomize(const QString&) - Took 4.6e-05s 
amarok:       END__: bool ScriptManager::slotRunScript(QString, bool) - Took 0.025s 
amarok:       BEGIN: bool ScriptManager::slotRunScript(QString, bool) 
amarok:         BEGIN: void ScriptManager::startScriptEngine(QString) 
amarok:           BEGIN: ScriptableServiceScript::ScriptableServiceScript(QScriptEngine*) 
amarok:           END__: ScriptableServiceScript::ScriptableServiceScript(QScriptEngine*) - Took 5.2e-05s 
amarok:           BEGIN: Downloader::Downloader(QScriptEngine*) 
amarok:           END__: Downloader::Downloader(QScriptEngine*) - Took 5.8e-05s 
amarok:         END__: void ScriptManager::startScriptEngine(QString) - Took 0.00074s 
amarok:         BEGIN: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) 
amarok:            importing qt bindings  "qt.core" 
amarok:         END__: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) - Took 0.069s 
amarok:         BEGIN: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) 
amarok:            importing qt bindings  "qt.xml" 
amarok:         END__: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) - Took 0.16s 
amarok:         BEGIN: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) 
amarok:            importing qt bindings  "qt.network" 
amarok:         END__: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) - Took 0.04s 
amarok:         BEGIN: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) 
amarok:            importing qt bindings  "qt.gui" 
amarok:         END__: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) - Took 0.089s 
amarok:          SCRIPT "Librivox.org" :  "creating service..." 
amarok:         BEGIN: static QScriptValue ScriptableServiceScript::ScriptableServiceScript_prototype_ctor(QScriptContext*, QScriptEngine*) 
amarok:           BEGIN: bool ScriptableServiceManager::initService(const QString&, int, const QString&, const QString&, bool) 
amarok:              initializing scripted service:  "Librivox.org" 
amarok:             BEGIN: ServiceBase::ServiceBase(const QString&, ServiceFactory*, bool, const QString&) 
amarok:             END__: ServiceBase::ServiceBase(const QString&, ServiceFactory*, bool, const QString&) - Took 0.0063s 
amarok:             BEGIN: ScriptableService::ScriptableService(const QString&) 
amarok:                creating ScriptableService  "Librivox.org" 
amarok:             END__: ScriptableService::ScriptableService(const QString&) - Took 6.2e-05s 
amarok:             BEGIN: void ScriptableService::init(int, const QString&, bool) 
amarok:               BEGIN: Collections::ScriptableServiceCollection::ScriptableServiceCollection(const QString&) 
amarok:               END__: Collections::ScriptableServiceCollection::ScriptableServiceCollection(const QString&) - Took 8.6e-05s 
amarok:             END__: void ScriptableService::init(int, const QString&, bool) - Took 0.00032s 
amarok:              emitting scripted service  "Librivox.org" 
amarok:             BEGIN: void ServiceBrowser::addService(ServiceBase*) 
amarok:             END__: void ServiceBrowser::addService(ServiceBase*) - Took 0.00014s 
amarok:           END__: bool ScriptableServiceManager::initService(const QString&, int, const QString&, const QString&, bool) - Took 0.0073s 
amarok:         END__: static QScriptValue ScriptableServiceScript::ScriptableServiceScript_prototype_ctor(QScriptContext*, QScriptEngine*) - Took 0.0075s 
amarok:          SCRIPT "Librivox.org" :  "done creating service!" 
amarok:         BEGIN: void ScriptableServiceScript::slotCustomize(const QString&) 
amarok:            SCRIPT "Librivox.org" :  "customizing Librivox service" 
amarok:            SCRIPT "Librivox.org" :  "loading icon: /opt/local/share/apps/amarok/scripts/librivox_service/LibrivoxIcon.png" 
amarok:           BEGIN: void ScriptableServiceManager::setIcon(const QString&, const QPixmap&) 
amarok:              service:  "Librivox.org" 
amarok:           END__: void ScriptableServiceManager::setIcon(const QString&, const QPixmap&) - Took 8e-05s 
amarok:         END__: void ScriptableServiceScript::slotCustomize(const QString&) - Took 0.0012s 
amarok:       END__: bool ScriptManager::slotRunScript(QString, bool) - Took 0.37s 
amarok:       BEGIN: bool ScriptManager::slotRunScript(QString, bool) 
amarok:         BEGIN: void ScriptManager::startScriptEngine(QString) 
amarok:           BEGIN: ScriptableServiceScript::ScriptableServiceScript(QScriptEngine*) 
amarok:           END__: ScriptableServiceScript::ScriptableServiceScript(QScriptEngine*) - Took 7.4e-05s 
amarok:           BEGIN: Downloader::Downloader(QScriptEngine*) 
amarok:           END__: Downloader::Downloader(QScriptEngine*) - Took 5.7e-05s 
amarok:         END__: void ScriptManager::startScriptEngine(QString) - Took 0.00097s 
amarok:         BEGIN: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) 
amarok:            importing qt bindings  "qt.core" 
amarok:         END__: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) - Took 0.059s 
amarok:         BEGIN: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) 
amarok:            importing qt bindings  "qt.xml" 
amarok:         END__: bool AmarokScript::ScriptImporter::loadQtBinding(const QString&) - Took 0.077s 
amarok:       END__: bool ScriptManager::slotRunScript(QString, bool) - Took 0.14s 
amarok:     END__: void ScriptManager::slotConfigChanged(bool) - Took 0.54s 
amarok:   END__: void ScriptManager::findScripts() - Took 0.54s 
amarok: END__: void ScriptManager::updateAllScripts() - Took 0.55s 
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
amarok: BEGIN: void App::checkCollectionScannerVersion() 
amarok: END__: void App::checkCollectionScannerVersion() - Took 0.026s 
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:30 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
Fri Sep 17 18:00:31 dn-14-037.sns.otago.ac.nz Amarok[76238] <Error>: CGAffineTransformInvert: singular matrix.
QPainter::begin: Paint device returned engine == 0, type: 2
QPainter::setCompositionMode: Painter not active
QPainter::setRenderHint: Painter must be active to set rendering hints
QPainter::save: Painter not active
QPainter::fillPath: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::translate: Painter not active
QPainter::setPen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setRenderHint: Painter must be active to set rendering hints
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::fillPath: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::setClipRegion: Painter not active
QPainter::save: Painter not active
QPainter::translate: Painter not active
QPainter::save: Painter not active
QPainter::pen: Painter not active
QPainter::setPen: Painter not active
QPainter::pen: Painter not active
QPainter::setPen: Painter not active
QPainter::setPen: Painter not active
QPainter::setPen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::restore: Unbalanced save/restore
QPainter::setRenderHint: Painter must be active to set rendering hints
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::save: Painter not active
QPainter::setPen: Painter not active
QPainter::translate: Painter not active
QPainter::pen: Painter not active
QPainter::restore: Unbalanced save/restore
QPainter::end: Painter not active, aborted
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.00056s 
QWidget::setMinimumSize: (Playlist dock/QDockWidget) Negative sizes (262,-1) are not possible
amarok: BEGIN: void Playlist::PrettyListView::trackActivated(const QModelIndex&) 
amarok:   BEGIN: void Playlist::Actions::play(const QModelIndex&) 
amarok:     BEGIN: void Playlist::Actions::play(quint64, bool) 
amarok:       BEGIN: void EngineController::play(const Meta::TrackPtr&, uint) 
amarok:         [EngineController] Just a normal, boring track... :-P 
amarok:         BEGIN: void EngineController::playUrl(const KUrl&, uint) 
amarok:           [EngineController] URL:  "file:///Users/michael/Music/Dream%20Theater/Dream%20Theater%20-%20Systematic%20Chaos%20FLAC%20EAC%202007/01%20-%20In%20The%20Presence%20Of%20Enemies%20-%20Part%20I.flac" 
amarok:           [EngineController] offset:  0 

FLACImportOpen...

FLACImportValidateDataRef...

FLACImportClose...

FLACImportOpen...

FLACImportDataRef...
        SetupDataHandler()
        InitFLACImporter()
        StartImport()
        Not using idle, importing movie here
Call to FLAC_ProcessMetadata : FLAC__METADATA_TYPE_STREAMINFO
        sample rate : 44100, sample size : 16, channels : 2
Call to FLAC_ProcessMetadata : FLAC__METADATA_TYPE_SEEKTABLE
Call to FLAC_ProcessMetadata : FLAC__METADATA_TYPE_VORBIS_COMMENT
comment : ALBUM=Systematic Chaos
comment length : 22
comment : ARTIST=Dream Theater
comment length : 20
comment : COMMENT=EAC-Secure Mode
comment length : 23
comment : DATE=2007
comment length : 9
comment : GENRE=Progressive Rock
comment length : 22
comment : LYRICS=I Prelude (instrumental)
...
comment length : 1077
comment : TITLE=In The Presence Of Enemies - Part I
comment length : 41
comment : TRACKNUMBER=1
comment length : 13
Youpi, EOF
Done
duration= 20480512
InsertMediaIntoTrack : 0 23821548
        FLAC Import completed
        Duration added : 23821548

FLACImportClose...
amarok:           BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:              returning bookmarkcurrenttrack action 
amarok:              returning bookmarkcurrenttrack action 
amarok:             BEGIN: virtual void Playlist::Actions::engineNewTrackPlaying() 
amarok:               BEGIN: void StatusBar::updateTotalPlaylistLength() 
amarok:               END__: void StatusBar::updateTotalPlaylistLength() - Took 0.00024s 
amarok:                returning bookmarkcurrenttrack action 
amarok:               BEGIN: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() 
amarok:                 BEGIN: void Playlist::PrettyListView::scrollToActiveTrack() 
amarok:                 END__: void Playlist::PrettyListView::scrollToActiveTrack() - Took 3.8e-05s 
amarok:               END__: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() - Took 0.00019s 
amarok:             END__: virtual void Playlist::Actions::engineNewTrackPlaying() - Took 0.0017s 
amarok:             BEGIN: virtual void Amarok::OSD::engineNewTrackPlaying() 
amarok:               BEGIN: void OSDWidget::show(const QString&, QImage) 
amarok:               END__: void OSDWidget::show(const QString&, QImage) - Took 0.033s 
amarok:             END__: virtual void Amarok::OSD::engineNewTrackPlaying() - Took 0.034s 
amarok:             BEGIN: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() 
amarok:             END__: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() - Took 6.6e-05s 
amarok:             BEGIN: virtual void Context::ContextView::engineNewTrackPlaying() 
amarok:               BEGIN: void WikipediaEngine::update() 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 4.5e-05s 
amarok:                  wiki url:  "http://en.wikipedia.org/w/index.php?title=Dream%20Theater%20%28band%29&useskin=monobook" 
amarok:               END__: void WikipediaEngine::update() - Took 0.00048s 
amarok:               BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:                 BEGIN: void CurrentEngine::update() 
amarok:                 END__: void CurrentEngine::update() - Took 0.013s 
amarok:               END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 0.013s 
amarok:               BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 6.4e-05s 
amarok:                 BEGIN: virtual void LyricsEngine::newLyrics(QStringList&) 
amarok:                 END__: virtual void LyricsEngine::newLyrics(QStringList&) - Took 0.00013s 
amarok:               END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.00096s 
amarok:             END__: virtual void Context::ContextView::engineNewTrackPlaying() - Took 0.022s 
amarok:             BEGIN: virtual void GrowlInterface::engineNewTrackPlaying() 
amarok:               BEGIN: virtual void GrowlInterface::metadataChanged(Meta::TrackPtr) 
amarok:               END__: virtual void GrowlInterface::metadataChanged(Meta::TrackPtr) - Took 3.8e-05s 
amarok:               BEGIN: void GrowlInterface::show(Meta::TrackPtr) 
amarok:               END__: void GrowlInterface::show(Meta::TrackPtr) - Took 0.0021s 
amarok:             END__: virtual void GrowlInterface::engineNewTrackPlaying() - Took 0.0023s 
amarok:             BEGIN: virtual void TimecodeObserver::engineNewTrackPlaying() 
amarok:                curent track name:  "In The Presence Of Enemies - Part I" 
amarok:                Track timecodeable 
amarok:             END__: virtual void TimecodeObserver::engineNewTrackPlaying() - Took 0.00037s 
amarok:             BEGIN: virtual void ProgressWidget::engineNewTrackPlaying() 
amarok:               BEGIN: virtual void ProgressWidget::engineTrackLengthChanged(qint64) 
amarok:                  new length:  540000 
amarok:                  slider enabled! 
amarok:                 BEGIN: void ProgressWidget::redrawBookmarks(const QString*) 
amarok:                   BEGIN: void Amarok::TimeSlider::clearTriangles() 
amarok:                      number of triangles:  0 
amarok:                      deleted them all... 
amarok:                   END__: void Amarok::TimeSlider::clearTriangles() - Took 0.00051s 
amarok:                    creating load timecode capability 
amarok:                    found  0  timecodes on this track 
amarok:                 END__: void ProgressWidget::redrawBookmarks(const QString*) - Took 0.0018s 
amarok:               END__: virtual void ProgressWidget::engineTrackLengthChanged(qint64) - Took 0.0027s 
amarok:             END__: virtual void ProgressWidget::engineNewTrackPlaying() - Took 0.0032s 
amarok:           END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.084s 
amarok:           BEGIN: void EngineController::slotMetaDataChanged() 
amarok:             [EngineController] Artist     :  ("") 
amarok:             [EngineController] Album      :  ("") 
amarok:             [EngineController] Title      :  ("In The Presence Of Enemies - Part I") 
amarok:             [EngineController] Genre      :  ("") 
amarok:             [EngineController] Tracknumber:  ("") 
amarok:             [EngineController] Length     :  () 
amarok:             [EngineController] Track changed:  true 
amarok:             BEGIN: void Engine::EngineSubject::newMetaDataNotify(const QHash<long long int, QString>&, bool) 
amarok:               BEGIN: virtual void Context::ContextView::engineNewMetaData(const QHash<long long int, QString>&, bool) 
amarok:               END__: virtual void Context::ContextView::engineNewMetaData(const QHash<long long int, QString>&, bool) - Took 8.8e-05s 
amarok:             END__: void Engine::EngineSubject::newMetaDataNotify(const QHash<long long int, QString>&, bool) - Took 0.0002s 
amarok:           END__: void EngineController::slotMetaDataChanged() - Took 0.00069s 
amarok:           BEGIN: void EngineController::slotTrackLengthChanged(qint64) 
amarok:             BEGIN: void MainToolbar::updateBookmarks(const QString*) 
amarok:               BEGIN: void Amarok::TimeSlider::clearTriangles() 
amarok:                  number of triangles:  0 
amarok:                  deleted them all... 
amarok:               END__: void Amarok::TimeSlider::clearTriangles() - Took 8.7e-05s 
amarok:                creating load timecode capability 
amarok:                found  0  timecodes on this track 
amarok:             END__: void MainToolbar::updateBookmarks(const QString*) - Took 0.0005s 
amarok:             BEGIN: virtual void ProgressWidget::engineTrackLengthChanged(qint64) 
amarok:                new length:  540170 
amarok:                slider enabled! 
amarok:               BEGIN: void ProgressWidget::redrawBookmarks(const QString*) 
amarok:                 BEGIN: void Amarok::TimeSlider::clearTriangles() 
amarok:                    number of triangles:  0 
amarok:                    deleted them all... 
amarok:                 END__: void Amarok::TimeSlider::clearTriangles() - Took 7.9e-05s 
amarok:                  creating load timecode capability 
amarok:                  found  0  timecodes on this track 
amarok:               END__: void ProgressWidget::redrawBookmarks(const QString*) - Took 0.00028s 
amarok:             END__: virtual void ProgressWidget::engineTrackLengthChanged(qint64) - Took 0.00041s 
amarok:           END__: void EngineController::slotTrackLengthChanged(qint64) - Took 0.0011s 
amarok:           BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:             BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:             END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 4e-05s 
amarok:           END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.00011s 
amarok:           BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:             BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:                State changed, oldState: 1 -> newState: 2 
amarok:                returning bookmarkcurrenttrack action 
amarok:                returning bookmarkcurrenttrack action 
amarok:               BEGIN: virtual void GrowlInterface::engineStateChanged(Phonon::State, Phonon::State) 
amarok:               END__: virtual void GrowlInterface::engineStateChanged(Phonon::State, Phonon::State) - Took 6.2e-05s 
amarok:             END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.0055s 
amarok:           END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.0056s 
amarok:           [EngineController] track pos after play:  0 
amarok:         END__: void EngineController::playUrl(const KUrl&, uint) - Took 2.7s 
amarok:       END__: void EngineController::play(const Meta::TrackPtr&, uint) - Took 2.7s 
amarok:     END__: void Playlist::Actions::play(quint64, bool) - Took 2.7s 
amarok:   END__: void Playlist::Actions::play(const QModelIndex&) - Took 2.7s 
amarok: END__: void Playlist::PrettyListView::trackActivated(const QModelIndex&) - Took 2.7s 
QWidget::setMinimumSize: (Playlist dock/QDockWidget) Negative sizes (262,-1) are not possible
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok:    returning bookmarkcurrenttrack action 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.0041s 
amarok:  painting action:  "" 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://en.wikipedia.org/w/index.php?title=Dream%20Theater%20%28band%29&useskin=monobook") 
amarok: BEGIN: void WikipediaEngine::wikiResult(KJob*) 
amarok: END__: void WikipediaEngine::wikiResult(KJob*) - Took 0.0089s 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://en.wikipedia.org/w/extensions/OggHandler/play.png") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/commons/thumb/e/e6/Dream_Theater_2326994259_c689a5f104_o.jpg/250px-Dream_Theater_2326994259_c689a5f104_o.jpg") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/en/thumb/7/72/Dream_1989.jpg/200px-Dream_1989.jpg") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/commons/thumb/c/cb/Gnome-mime-audio-openclipart.svg/50px-Gnome-mime-audio-openclipart.svg.png") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/en/5/51/Dream_theater_in_1985.jpg") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/commons/thumb/f/fd/Portal-puzzle.svg/32px-Portal-puzzle.svg.png") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/commons/thumb/e/ec/Dream_theater_live_in_Parigi_2005.jpg/250px-Dream_theater_live_in_Parigi_2005.jpg") 
amarok: BEGIN: void Amarok::KNotificationBackend::showCurrentTrack() 
amarok: END__: void Amarok::KNotificationBackend::showCurrentTrack() - Took 6.5e-05s 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/en/thumb/9/98/Majesty.svg/170px-Majesty.svg.png") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/en/timeline/fad1ca6e2f5dc32225a41c92dbeffd29.png") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/commons/thumb/d/dd/Dream_Theater_Live_in_Argentina_03-03-08.jpg/250px-Dream_Theater_Live_in_Argentina_03-03-08.jpg") 
amarok(76238)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://upload.wikimedia.org/wikipedia/commons/thumb/4/4a/Commons-logo.svg/30px-Commons-logo.svg.png") 
QWidget::setMinimumSize: (Playlist dock/QDockWidget) Negative sizes (262,-1) are not possible
QWidget::setMinimumSize: (Media Sources dock/QDockWidget) Negative sizes (100,-1) are not possible
QWidget::setMinimumSize: (Playlist dock/QDockWidget) Negative sizes (262,-1) are not possible
amarok: BEGIN: virtual void CollectionTreeView::startDrag(Qt::DropActions) 
amarok:   BEGIN: PopupDropper* PopupDropperFactory::createPopupDropper(QWidget*) 
link XMLID_9_ hasn't been detected!
link XMLID_9_ hasn't been detected!
link XMLID_9_ hasn't been detected!
link XMLID_9_ hasn't been detected!
Could not resolve property : linearGradient5167
Could not resolve property : linearGradient3563
Could not resolve property : linearGradient3563-3
Could not resolve property : linearGradient3563-3
amarok:   END__: PopupDropper* PopupDropperFactory::createPopupDropper(QWidget*) - Took 0.062s 
amarok:   BEGIN: bool CollectionTreeView::onlyOneCollection(const QModelIndexList&) 
amarok:   END__: bool CollectionTreeView::onlyOneCollection(const QModelIndexList&) - Took 6.9e-05s 
amarok:   BEGIN: virtual bool Collections::SqlCollectionLocation::isWritable() const 
amarok:     BEGIN: QStringList MountPointManager::collectionFolders() 
amarok:     END__: QStringList MountPointManager::collectionFolders() - Took 0.00013s 
amarok:      "/Users/michael/Music" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/AudioSlave" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/Billy Talent" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/Cat Stevens" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/Kings of Leon" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:   END__: virtual bool Collections::SqlCollectionLocation::isWritable() const - Took 0.0019s 
amarok:   BEGIN: bool CollectionTreeView::onlyOneCollection(const QModelIndexList&) 
amarok:   END__: bool CollectionTreeView::onlyOneCollection(const QModelIndexList&) - Took 4.3e-05s 
amarok:   BEGIN: virtual bool Collections::SqlCollectionLocation::isWritable() const 
amarok:     BEGIN: QStringList MountPointManager::collectionFolders() 
amarok:     END__: QStringList MountPointManager::collectionFolders() - Took 0.00026s 
amarok:      "/Users/michael/Music" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/AudioSlave" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/Billy Talent" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/Cat Stevens" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:      "/Volumes/music/Kings of Leon" 
amarok:         used:  2.24871e+13 
amarok:         total:  3.29853e+13 
amarok:         free space:  1.04983e+13 
amarok:         path_exists_writeable true 
amarok:         path_exists_with_space true 
amarok:   END__: virtual bool Collections::SqlCollectionLocation::isWritable() const - Took 0.0019s 
amarok:    checking for global actions 
amarok:   BEGIN: PopupDropper* PopupDropperFactory::createPopupDropper(QWidget*) 
amarok:   END__: PopupDropper* PopupDropperFactory::createPopupDropper(QWidget*) - Took 0.00093s 
amarok:   BEGIN: virtual void CollectionTreeView::startDrag(Qt::DropActions) 
amarok:   END__: virtual void CollectionTreeView::startDrag(Qt::DropActions) - Took 0.0001s 
Unable to start Dr. Konqi
Comment 10 Myriam Schweingruber 2011-05-07 11:30:24 UTC
Could you please upgrade to a newer Amarok version and test again? Current is Amarok 2.4.0, Amarok 2.4.1 is to be released tomorrow.

Please report back.
Comment 11 Myriam Schweingruber 2011-06-16 14:07:07 UTC
Any news on this? Without feedback within the next two weeks I will close it as solved.
Comment 12 Myriam Schweingruber 2011-07-15 09:05:17 UTC
Closing for lack of feedback. Feel free to reopen if you can still reproduce this with Amarok 2.4.2 beta 1 or later and provide the necessary feedback.