Bug 238458

Summary: Audio CDs will not play
Product: [Frameworks and Libraries] kio-extras Reporter: Valorie Zimmerman <valorie.zimmerman>
Component: AudioCDAssignee: Plasma Bugs List <plasma-bugs>
Status: RESOLVED WORKSFORME    
Severity: normal CC: nate, paul.leopardi, roderick.greening, yurchor
Priority: NOR    
Version: unspecified   
Target Milestone: ---   
Platform: Ubuntu   
OS: Linux   
Latest Commit: Version Fixed In:
Sentry Crash Report:

Description Valorie Zimmerman 2010-05-22 04:58:14 UTC 
Version:            (using KDE 4.4.3)
Compiler:          gcc version 4.4.3 Using built-in specs. Target: x86_64-linux-gnu
OS:                Linux
Installed from:    Ubuntu Packages

After finding CD playing in Amarok failing, I discussed this with the Kubuntu devels. This is what we found out:

CD Audio in general appears broken. Kaffiene, Dragon and Amarok all fail to play Audio CD's. Well, Kaffiene plays the first song and I cannot skip to any other songs. kscd doesn't work either. Only vlc works, which doesn't use the KDE backends. Looks to be a bug with KDE looking for /dev/cdrom regardless of how Audio CD is configured in system settings. On my system my cdrom shows up as /dev/cdrom4 -> /dev/sr0. Seems it only works if I symlink /dev/cdrom -> /dev/sr0. This is bad. Guess 1) udev rules needs a fix and 2) KDE need some fixing to be not so restrictive?

More testing: running amarok from cmdline and with "Specify CD Device" unchecked, amarok still does this...
Checking /dev/cdrom for cdrom... Could not stat /dev/cdrom: No
such file or directory. And checking the box again but setting it to the correct /dev/cdrom1, amarok still spits out looking for /dev/cdrom

Amarok from master does not play cd here, neither from cdrom nor from cdrom1
[14:17] <rgreening> [09:52:50] ok, so not a distro problem necessarily...
[14:17] <rgreening> [09:53:02] unless it's a udev/hal issue

I've queried the Amarok developers about this without reply. The Kubuntu devels know this bug is being filed.

Full output paste: http://pastie.org/971665

Amarok output: 

amarok:               BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:               END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 8.5e-05s 
amarok:             END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.0002s 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
amarok:             [EngineController] URL:  "audiocd:/n4vsvTMhSSqJfKZu3hNR.jjbNmg-/2" 
amarok:             [EngineController] offset:  0 
amarok:             [EngineController] play track from cd 
amarok:             [EngineController] 3.2.1... 
amarok:             [EngineController] boom? 
amarok:             [EngineController] no boom? 
amarok:             BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:               BEGIN: virtual void ProgressWidget::engineNewTrackPlaying() 
amarok:                 BEGIN: virtual void ProgressWidget::engineTrackLengthChanged(qint64) 
amarok:                    new length:  0 
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.0004s 
amarok:                   END__: void ProgressWidget::redrawBookmarks(const QString*) - Took 0.00073s 
amarok:                 END__: virtual void ProgressWidget::engineTrackLengthChanged(qint64) - Took 0.0013s 
amarok:               END__: virtual void ProgressWidget::engineNewTrackPlaying() - Took 0.0018s 
amarok:               BEGIN: virtual void ScrobblerAdapter::engineNewTrackPlaying() 
amarok:                 [lastfm] track type: "ogg" 
amarok:                 BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:                   [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:                 END__: void ScrobblerAdapter::checkScrobble() - Took 0.00029s 
amarok:                 [lastfm] nowPlaying:  "IAMX"  -  "Kingdom of Welcome Addiction"  -  "Kingdom of Welcome Addiction" 
amarok:               END__: virtual void ScrobblerAdapter::engineNewTrackPlaying() - Took 0.0015s 
amarok:               BEGIN: virtual void TimecodeObserver::engineNewTrackPlaying() 
amarok:               END__: virtual void TimecodeObserver::engineNewTrackPlaying() - Took 0.00027s 
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.00024s 
amarok:               END__: virtual void Amarok::OSD::engineNewTrackPlaying() - Took 0.0017s 
amarok:               BEGIN: virtual void Playlist::Actions::engineNewTrackPlaying() 
amarok:                 BEGIN: void StatusBar::updateTotalPlaylistLength() 
amarok:                 END__: void StatusBar::updateTotalPlaylistLength() - Took 0.001s 
amarok:                 BEGIN: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() 
amarok:                   BEGIN: void Playlist::PrettyListView::scrollToActiveTrack() 
amarok:                   END__: void Playlist::PrettyListView::scrollToActiveTrack() - Took 0.0026s 
amarok:                 END__: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() - Took 0.0029s 
amarok:               END__: virtual void Playlist::Actions::engineNewTrackPlaying() - Took 0.0056s 
amarok:               BEGIN: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() 
amarok:               END__: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() - Took 0.0002s 
amarok:               BEGIN: virtual void SimilarArtistsApplet::engineNewTrackPlaying() 
amarok:               END__: virtual void SimilarArtistsApplet::engineNewTrackPlaying() - Took 5.5e-05s 
amarok:               BEGIN: virtual void Context::ContextView::engineNewTrackPlaying() 
amarok:                 BEGIN: void WikipediaEngine::update() 
amarok:                   BEGIN: bool EngineController::isStream() 
amarok:                   END__: bool EngineController::isStream() - Took 4e-05s 
amarok:                    Same entry requested again. Ignoring. 
amarok:                 END__: void WikipediaEngine::update() - Took 0.00028s 
amarok:                 BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:                   BEGIN: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) 
amarok:                   END__: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) - Took 0.00037s 
amarok:                 END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.00059s 
amarok:                 BEGIN: void UpcomingEventsEngine::update() 
amarok:                   BEGIN: bool EngineController::isStream() 
amarok:                   END__: bool EngineController::isStream() - Took 3.9e-05s 
amarok:                 END__: void UpcomingEventsEngine::update() - Took 0.00026s 
amarok:                 BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:                   BEGIN: void CurrentEngine::update() 
amarok:                   END__: void CurrentEngine::update() - Took 0.00015s 
amarok:                 END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 0.00028s 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 3.8e-05s 
amarok:               END__: virtual void Context::ContextView::engineNewTrackPlaying() - Took 0.0018s 
amarok:             END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.065s 
play 
[0x3094df8] main input debug: Creating an input for '(null)'
[0x134f8e8] main playlist debug: no fetch required for (null) (art currently (null))
[0x35c4d08] main input debug: Creating an input for '(null)'
[0x35c4d08] main input debug: thread (input) created at priority 10 (input/input.c:214)
updateVolume Volume changed to -  32  From  32 
amarok:             [EngineController] track pos after play:  0 
amarok:           END__: void EngineController::playUrl(const KUrl&, uint) - Took 0.07s 
amarok:         END__: void EngineController::play(const Meta::TrackPtr&, uint) - Took 0.07s 
amarok:       END__: void EngineController::setNextTrack(Meta::TrackPtr) - Took 0.07s 
amarok:     END__: void Playlist::Actions::play(quint64, bool) - Took 0.07s 
amarok:   END__: void Playlist::Actions::requestNextTrack() - Took 0.07s 
amarok:   BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:      State changed, oldState: 1 -> newState: 5 
amarok:     [Playlist::Actions] [WARNING!] Error, can not play this track. 
amarok:     [Playlist::Actions] [WARNING!] Failure count:  2 
[0x35c4d08] main input debug: thread started
[0x35c4d08] main input debug: using timeshift granularity of 50 MiB
[0x35c4d08] main input debug: using timeshift path '/tmp'
[0x35c4d08] main input debug: `' gives access `' demux `' path `'
[0x35c4d08] main input debug: creating demux: access='' demux='' path=''
[0x2f45ca8] main demux debug: looking for access_demux module: 14 candidates
[0x2f45ca8] main demux debug: no access_demux module matching "any" could be loaded
amarok:   END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.0063s 
[0x35c4d08] main input debug: creating access '' path=''
amarok: END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.077s 
amarok: BEGIN: void EngineController::slotQueueEnded() 
[0x2f0e528] main access debug: looking for access module: 10 candidates
[0x2f0e528] filesystem access debug: opening file `'
[0x2f0e528] filesystem access error: cannot open file  (No such file or directory)
[0x2f0e528] main access error: File reading failed
[0x2f0e528] main access error: VLC could not open the file "".
[0x2f0e528] filesystem access debug: opening file `'
[0x2f0e528] filesystem access error: cannot open file  (No such file or directory)
[0x2f0e528] main access error: File reading failed
[0x2f0e528] main access error: VLC could not open the file "".
[0x2f0e528] main access debug: no access module matching "any" could be loaded
[0x35c4d08] main input debug: thread ended
stateChangedInternal newState: "StoppedState" previousState: "StoppedState" 
setSource 
setSource Error: MediaSource is empty. 
amarok:   BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:     [EngineController] Empty MediaSource (engine stop) 
amarok:   END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 9.6e-05s 
amarok:   BEGIN: virtual void ProgressWidget::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: void Amarok::TimeSlider::clearTriangles() 
amarok:        number of triangles:  0 
amarok:        deleted them all... 
amarok:     END__: void Amarok::TimeSlider::clearTriangles() - Took 0.00011s 
amarok:   END__: virtual void ProgressWidget::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00018s 
amarok:   BEGIN: virtual void ScrobblerAdapter::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:       [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:     END__: void ScrobblerAdapter::checkScrobble() - Took 9.7e-05s 
amarok:   END__: virtual void ScrobblerAdapter::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00018s 
amarok:   BEGIN: virtual void TimecodeObserver::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:   END__: virtual void TimecodeObserver::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 3.5e-05s 
amarok:   BEGIN: virtual void Context::ContextView::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:     END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 9.5e-05s 
amarok:     BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:     END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 6.8e-05s 
amarok:   END__: virtual void Context::ContextView::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00037s 
amarok: END__: void EngineController::slotQueueEnded() - Took 0.01s 
amarok: BEGIN: void UpcomingEventsApplet::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void UpcomingEventsApplet::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.014s 
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.0011s 
amarok: BEGIN: virtual void UpcomingEventsApplet::constraintsEvent(Plasma::Constraints) 
QWidget::setMinimumSize: (/QWidget) Negative sizes (720,-51) are not possible
QWidget::setMaximumSize: (/QWidget) Negative sizes (720,-51) are not possible
amarok: END__: virtual void UpcomingEventsApplet::constraintsEvent(Plasma::Constraints) - Took 0.0018s 
amarok(2792)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://userserve-ak.last.fm/serve/126/30388031.jpg") 
amarok(2792)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://userserve-ak.last.fm/serve/126/16192805.jpg") 
amarok: BEGIN: void AmarokDownloadHelper::resultData(KJob*) 
amarok:   BEGIN: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) 
amarok:   END__: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) - Took 0.00035s 
amarok: END__: void AmarokDownloadHelper::resultData(KJob*) - Took 0.0086s 
amarok: BEGIN: void AmarokDownloadHelper::resultData(KJob*) 
amarok:   BEGIN: void AmarokScript::AmarokLyricsScript::showLyrics(const QString&) const 
amarok:   END__: void AmarokScript::AmarokLyricsScript::showLyrics(const QString&) const - Took 0.00017s 
amarok: END__: void AmarokDownloadHelper::resultData(KJob*) - Took 0.0053s 
amarok(2792) KNetworkReply::setMimeType: "text/plain"
"OK" 
amarok: BEGIN: void CurrentEngine::stoppedState() 
amarok: END__: void CurrentEngine::stoppedState() - Took 0.0015s 
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.00066s 
amarok: BEGIN: void CurrentEngine::resultReady(const QString&, const Meta::TrackList&) 
amarok: END__: void CurrentEngine::resultReady(const QString&, const Meta::TrackList&) - Took 0.00037s 
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.0005s 
amarok: BEGIN: void EngineController::play() 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
amarok:   BEGIN: void Playlist::Actions::play() 
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) 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
amarok:           [EngineController] URL:  "audiocd:/n4vsvTMhSSqJfKZu3hNR.jjbNmg-/2" 
amarok:           [EngineController] offset:  0 
amarok:           [EngineController] play track from cd 
amarok:           [EngineController] 3.2.1... 
setSource 
setSource Error: MediaSource is empty. 
amarok:           BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:             [EngineController] Empty MediaSource (engine stop) 
amarok:           END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.00014s 
setSource 
"" 
stateChangedInternal newState: "BufferingState" previousState: "StoppedState" 
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: 3 
amarok:             END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.0015s 
amarok:           END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.0017s 
loadMediaInternal "" 
stateChangedInternal newState: "StoppedState" previousState: "BufferingState" 
amarok:           BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:             BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:                State changed, oldState: 3 -> newState: 1 
amarok:             END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.0066s 
amarok:           END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.0068s 
amarok:           BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:             BEGIN: virtual void ProgressWidget::engineNewTrackPlaying() 
amarok:               BEGIN: virtual void ProgressWidget::engineTrackLengthChanged(qint64) 
amarok:                  new length:  0 
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:                 END__: void ProgressWidget::redrawBookmarks(const QString*) - Took 0.00015s 
amarok:               END__: virtual void ProgressWidget::engineTrackLengthChanged(qint64) - Took 0.00029s 
amarok:             END__: virtual void ProgressWidget::engineNewTrackPlaying() - Took 0.00043s 
amarok:             BEGIN: virtual void ScrobblerAdapter::engineNewTrackPlaying() 
amarok:               [lastfm] track type: "ogg" 
amarok:               BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:                 [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:               END__: void ScrobblerAdapter::checkScrobble() - Took 8.5e-05s 
amarok:               [lastfm] nowPlaying:  "IAMX"  -  "Kingdom of Welcome Addiction"  -  "Kingdom of Welcome Addiction" 
amarok:             END__: virtual void ScrobblerAdapter::engineNewTrackPlaying() - Took 0.00035s 
amarok:             BEGIN: virtual void TimecodeObserver::engineNewTrackPlaying() 
amarok:             END__: virtual void TimecodeObserver::engineNewTrackPlaying() - Took 3.9e-05s 
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.0002s 
amarok:             END__: virtual void Amarok::OSD::engineNewTrackPlaying() - Took 0.045s 
amarok:             BEGIN: virtual void Playlist::Actions::engineNewTrackPlaying() 
amarok:               BEGIN: void StatusBar::updateTotalPlaylistLength() 
amarok:               END__: void StatusBar::updateTotalPlaylistLength() - Took 0.00042s 
amarok:               BEGIN: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() 
amarok:                 BEGIN: void Playlist::PrettyListView::scrollToActiveTrack() 
amarok:                 END__: void Playlist::PrettyListView::scrollToActiveTrack() - Took 0.00082s 
amarok:               END__: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() - Took 0.00096s 
amarok:             END__: virtual void Playlist::Actions::engineNewTrackPlaying() - Took 0.002s 
amarok:             BEGIN: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() 
amarok:             END__: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() - Took 0.00015s 
amarok:             BEGIN: virtual void SimilarArtistsApplet::engineNewTrackPlaying() 
amarok:               BEGIN: void Context::Applet::setCollapseOff() 
amarok:                  height: 36 target: -1 m_collapsed: false 
amarok:               END__: void Context::Applet::setCollapseOff() - Took 0.00013s 
amarok:               BEGIN: void Context::Applet::setCollapseOff() 
amarok:                  height: 36 target: -1 m_collapsed: false 
amarok:               END__: void Context::Applet::setCollapseOff() - Took 0.00014s 
amarok:               BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:               END__: void ArtistWidget::elideArtistDescription() - Took 0.0012s 
amarok:               BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:               END__: void ArtistWidget::elideArtistDescription() - Took 0.00074s 
amarok:               BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:               END__: void ArtistWidget::elideArtistDescription() - Took 0.00075s 
amarok:               BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:               END__: void ArtistWidget::elideArtistDescription() - Took 0.00087s 
amarok:               BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:               END__: void ArtistWidget::elideArtistDescription() - Took 0.00078s 
amarok:             END__: virtual void SimilarArtistsApplet::engineNewTrackPlaying() - Took 0.021s 
amarok:             BEGIN: virtual void Context::ContextView::engineNewTrackPlaying() 
amarok:               BEGIN: void WikipediaEngine::update() 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 4.6e-05s 
amarok:                  Same entry requested again. Ignoring. 
amarok:               END__: void WikipediaEngine::update() - Took 0.00057s 
amarok:               BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:                 BEGIN: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) 
amarok:                   BEGIN: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) 
amarok:                   END__: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) - Took 0.00039s 
amarok:                 END__: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) - Took 0.013s 
amarok:               END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.013s 
amarok:               BEGIN: void UpcomingEventsEngine::update() 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 3.9e-05s 
amarok:               END__: void UpcomingEventsEngine::update() - Took 0.00027s 
amarok:               BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:                 BEGIN: void CurrentEngine::update() 
amarok:                 END__: void CurrentEngine::update() - Took 0.00015s 
amarok:               END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 0.00023s 
amarok:               BEGIN: bool EngineController::isStream() 
amarok:               END__: bool EngineController::isStream() - Took 3.9e-05s 
amarok:             END__: virtual void Context::ContextView::engineNewTrackPlaying() - Took 0.014s 
amarok:           END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.1s 
amarok:           [EngineController] boom? 
amarok:           [EngineController] no boom? 
play 
[0x33838c8] main input debug: Creating an input for '(null)'
[0x33838c8] main input debug: thread (input) created at priority 10 (input/input.c:214)
updateVolume Volume changed to -  32  From  32 
amarok:           [EngineController] track pos after play:  0 
amarok:         END__: void EngineController::playUrl(const KUrl&, uint) - Took 0.12s 
amarok:       END__: void EngineController::play(const Meta::TrackPtr&, uint) - Took 0.12s 
amarok:     END__: void Playlist::Actions::play(quint64, bool) - Took 0.12s 
amarok:   END__: void Playlist::Actions::play() - Took 0.12s 
amarok: END__: void EngineController::play() - Took 0.12s 
[0x2f83ca8] main input debug: Creating an input for '(null)'
[0x134f8e8] main playlist debug: no fetch required for (null) (art currently (null))
[0x33838c8] main input debug: thread started
[0x33838c8] main input debug: using timeshift granularity of 50 MiB
[0x33838c8] main input debug: using timeshift path '/tmp'
[0x33838c8] main input debug: `' gives access `' demux `' path `'
[0x33838c8] main input debug: creating demux: access='' demux='' path=''
[0x43b7668] main demux debug: looking for access_demux module: 14 candidates
[0x43b7668] main demux debug: no access_demux module matching "any" could be loaded
[0x33838c8] main input debug: creating access '' path=''
[0x2ddd018] main access debug: looking for access module: 10 candidates
[0x2ddd018] filesystem access debug: opening file `'
[0x2ddd018] filesystem access error: cannot open file  (No such file or directory)
[0x2ddd018] main access error: File reading failed
[0x2ddd018] main access error: VLC could not open the file "".
[0x2ddd018] filesystem access debug: opening file `'
[0x2ddd018] filesystem access error: cannot open file  (No such file or directory)
[0x2ddd018] main access error: File reading failed
[0x2ddd018] main access error: VLC could not open the file "".
[0x2ddd018] main access debug: no access module matching "any" could be loaded
[0x33838c8] main input error: open of `' failed: (null)
[0x33838c8] main input error: Your input can't be opened
[0x33838c8] main input error: VLC is unable to open the MRL ''. Check the log for details.
[0x33838c8] main input debug: thread ended
amarok: BEGIN: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) 
amarok: END__: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) - Took 0.00017s 
amarok: BEGIN: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) 
amarok: END__: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) - Took 3.9e-05s 
amarok: BEGIN: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) 
amarok: END__: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) - Took 3.6e-05s 
amarok: BEGIN: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) 
amarok: END__: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) - Took 8.4e-05s 
amarok: BEGIN: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) 
amarok: END__: void ArtistWidget::resultReady(const QString&, const Meta::ArtistList&) - Took 3.5e-05s 
stateChangedInternal newState: "ErrorState" previousState: "StoppedState" 
amarok: BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:   [EngineController] [WARNING!] Phonon failed to play this URL. Error:  "No active input" 
amarok:   BEGIN: void Playlist::Actions::requestNextTrack() 
amarok:     [Playlist::Actions] so far so good! 
amarok:     BEGIN: void Playlist::Actions::play(quint64, bool) 
amarok:       BEGIN: void EngineController::setNextTrack(Meta::TrackPtr) 
amarok:         [EngineController] locking mutex 
amarok:         [EngineController] locked! 
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) 
stateChangedInternal newState: "StoppedState" previousState: "ErrorState" 
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 4.4e-05s 
amarok:             END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.00012s 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
amarok:             [EngineController] URL:  "audiocd:/n4vsvTMhSSqJfKZu3hNR.jjbNmg-/3" 
amarok:             [EngineController] offset:  0 
amarok:             [EngineController] play track from cd 
amarok:             [EngineController] 3.2.1... 
amarok:             [EngineController] boom? 
amarok:             [EngineController] no boom? 
amarok:             BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:               BEGIN: virtual void ProgressWidget::engineNewTrackPlaying() 
amarok:                 BEGIN: virtual void ProgressWidget::engineTrackLengthChanged(qint64) 
amarok:                    new length:  0 
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.00011s 
amarok:                   END__: void ProgressWidget::redrawBookmarks(const QString*) - Took 0.00023s 
amarok:                 END__: virtual void ProgressWidget::engineTrackLengthChanged(qint64) - Took 0.00039s 
amarok:               END__: virtual void ProgressWidget::engineNewTrackPlaying() - Took 0.00052s 
amarok:               BEGIN: virtual void ScrobblerAdapter::engineNewTrackPlaying() 
amarok:                 [lastfm] track type: "ogg" 
amarok:                 BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:                   [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:                 END__: void ScrobblerAdapter::checkScrobble() - Took 0.00011s 
amarok:                 [lastfm] nowPlaying:  "IAMX"  -  "Kingdom of Welcome Addiction"  -  "Tear Garden" 
amarok:               END__: virtual void ScrobblerAdapter::engineNewTrackPlaying() - Took 0.00034s 
amarok:               BEGIN: virtual void TimecodeObserver::engineNewTrackPlaying() 
amarok:               END__: virtual void TimecodeObserver::engineNewTrackPlaying() - Took 4e-05s 
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.00016s 
amarok:               END__: virtual void Amarok::OSD::engineNewTrackPlaying() - Took 0.0027s 
amarok:               BEGIN: virtual void Playlist::Actions::engineNewTrackPlaying() 
amarok:                 BEGIN: void StatusBar::updateTotalPlaylistLength() 
amarok:                 END__: void StatusBar::updateTotalPlaylistLength() - Took 0.00036s 
amarok:                 BEGIN: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() 
amarok:                   BEGIN: void Playlist::PrettyListView::scrollToActiveTrack() 
amarok:                   END__: void Playlist::PrettyListView::scrollToActiveTrack() - Took 0.00077s 
amarok:                 END__: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() - Took 0.00091s 
amarok:               END__: virtual void Playlist::Actions::engineNewTrackPlaying() - Took 0.0019s 
amarok:               BEGIN: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() 
amarok:               END__: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() - Took 0.00011s 
amarok:               BEGIN: virtual void SimilarArtistsApplet::engineNewTrackPlaying() 
amarok:               END__: virtual void SimilarArtistsApplet::engineNewTrackPlaying() - Took 4.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.1e-05s 
amarok:                    Same entry requested again. Ignoring. 
amarok:                 END__: void WikipediaEngine::update() - Took 0.00022s 
amarok:                 BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:                   BEGIN: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) 
amarok:                   END__: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) - Took 0.00031s 
amarok:                 END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.00047s 
amarok:                 BEGIN: void UpcomingEventsEngine::update() 
amarok:                   BEGIN: bool EngineController::isStream() 
amarok:                   END__: bool EngineController::isStream() - Took 3.9e-05s 
amarok:                 END__: void UpcomingEventsEngine::update() - Took 0.00021s 
amarok:                 BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:                   BEGIN: void CurrentEngine::update() 
amarok:                   END__: void CurrentEngine::update() - Took 0.00015s 
amarok:                 END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 0.00023s 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 3.8e-05s 
amarok:               END__: virtual void Context::ContextView::engineNewTrackPlaying() - Took 0.0014s 
amarok:             END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.012s 
play 
[0x25deda8] main input debug: Creating an input for '(null)'
[0x25deda8] main input debug: thread (input) created at priority 10 (input/input.c:214)
updateVolume Volume changed to -  32  From  32 
amarok:             [EngineController] track pos after play:  0 
amarok:           END__: void EngineController::playUrl(const KUrl&, uint) - Took 0.013s 
amarok:         END__: void EngineController::play(const Meta::TrackPtr&, uint) - Took 0.013s 
amarok:       END__: void EngineController::setNextTrack(Meta::TrackPtr) - Took 0.014s 
amarok:     END__: void Playlist::Actions::play(quint64, bool) - Took 0.014s 
amarok:   END__: void Playlist::Actions::requestNextTrack() - Took 0.014s 
amarok:   BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:      State changed, oldState: 1 -> newState: 5 
amarok:     [Playlist::Actions] [WARNING!] Error, can not play this track. 
amarok:     [Playlist::Actions] [WARNING!] Failure count:  3 
[0x25deda8] main input debug: thread started
[0x25deda8] main input debug: using timeshift granularity of 50 MiB
[0x25deda8] main input debug: using timeshift path '/tmp'
[0x25deda8] main input debug: `' gives access `' demux `' path `'
[0x25deda8] main input debug: creating demux: access='' demux='' path=''
[0x43b7668] main demux debug: looking for access_demux module: 14 candidates
[0x43b7668] main demux debug: no access_demux module matching "any" could be loaded
[0x25deda8] main input debug: creating access '' path=''
[0x3ef1ef8] main access debug: looking for access module: 10 candidates
[0x3ef1ef8] filesystem access debug: opening file `'
[0x3ef1ef8] filesystem access error: cannot open file  (No such file or directory)
[0x3ef1ef8] main access error: File reading failed
[0x3ef1ef8] main access error: VLC could not open the file "".
[0x3ef1ef8] filesystem access debug: opening file `'
[0x3ef1ef8] filesystem access error: cannot open file  (No such file or directory)
[0x3ef1ef8] main access error: File reading failed
[0x3ef1ef8] main access error: VLC could not open the file "".
[0x3ef1ef8] main access debug: no access module matching "any" could be loaded
[0x25deda8] main input error: open of `' failed: (null)
[0x25deda8] main input error: Your input can't be opened
[0x25deda8] main input error: VLC is unable to open the MRL ''. Check the log for details.
[0x25deda8] main input debug: thread ended
[0x44086c8] main input debug: Creating an input for '(null)'
[0x134f8e8] main playlist debug: no fetch required for (null) (art currently (null))
amarok:   END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.007s 
amarok: END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.023s 
amarok: BEGIN: void EngineController::slotQueueEnded() 
stateChangedInternal newState: "StoppedState" previousState: "StoppedState" 
setSource 
setSource Error: MediaSource is empty. 
amarok:   BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:     [EngineController] Empty MediaSource (engine stop) 
amarok:   END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 6.1e-05s 
amarok:   BEGIN: virtual void ProgressWidget::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: void Amarok::TimeSlider::clearTriangles() 
amarok:        number of triangles:  0 
amarok:        deleted them all... 
amarok:     END__: void Amarok::TimeSlider::clearTriangles() - Took 7.4e-05s 
amarok:   END__: virtual void ProgressWidget::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00014s 
amarok:   BEGIN: virtual void ScrobblerAdapter::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:       [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:     END__: void ScrobblerAdapter::checkScrobble() - Took 0.0001s 
amarok:   END__: virtual void ScrobblerAdapter::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00018s 
amarok:   BEGIN: virtual void TimecodeObserver::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:   END__: virtual void TimecodeObserver::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 3.7e-05s 
amarok:   BEGIN: virtual void Context::ContextView::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:     END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.00014s 
amarok:     BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:     END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 9.9e-05s 
amarok:   END__: virtual void Context::ContextView::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00059s 
amarok: END__: void EngineController::slotQueueEnded() - Took 0.0082s 
stateChangedInternal newState: "ErrorState" previousState: "StoppedState" 
amarok: BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:   [EngineController] [WARNING!] Phonon failed to play this URL. Error:  "No active input" 
amarok:   BEGIN: void Playlist::Actions::requestNextTrack() 
amarok:     [Playlist::Actions] so far so good! 
amarok:     BEGIN: void Playlist::Actions::play(quint64, bool) 
amarok:       BEGIN: void EngineController::setNextTrack(Meta::TrackPtr) 
amarok:         [EngineController] locking mutex 
amarok:         [EngineController] locked! 
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) 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
"PVLC(2): createObject() : VolumeFaderEffect not implemented" 
amarok:             [EngineController] URL:  "audiocd:/n4vsvTMhSSqJfKZu3hNR.jjbNmg-/4" 
amarok:             [EngineController] offset:  0 
amarok:             [EngineController] play track from cd 
amarok:             [EngineController] 3.2.1... 
setSource 
setSource Error: MediaSource is empty. 
amarok:             BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:               [EngineController] Empty MediaSource (engine stop) 
amarok:             END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 9.1e-05s 
setSource 
"" 
stateChangedInternal newState: "BufferingState" previousState: "ErrorState" 
amarok:             BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:               BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:                  State changed, oldState: 5 -> newState: 3 
amarok:               END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.00096s 
amarok:             END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.0011s 
loadMediaInternal "" 
stateChangedInternal newState: "StoppedState" previousState: "BufferingState" 
amarok:             BEGIN: void EngineController::slotStateChanged(Phonon::State, Phonon::State) 
amarok:               BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:                  State changed, oldState: 3 -> newState: 1 
amarok:               END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.0052s 
amarok:             END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.0053s 
amarok:             BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:               BEGIN: virtual void ProgressWidget::engineNewTrackPlaying() 
amarok:                 BEGIN: virtual void ProgressWidget::engineTrackLengthChanged(qint64) 
amarok:                    new length:  0 
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.00011s 
amarok:                   END__: void ProgressWidget::redrawBookmarks(const QString*) - Took 0.00023s 
amarok:                 END__: virtual void ProgressWidget::engineTrackLengthChanged(qint64) - Took 0.00039s 
amarok:               END__: virtual void ProgressWidget::engineNewTrackPlaying() - Took 0.00053s 
amarok:               BEGIN: virtual void ScrobblerAdapter::engineNewTrackPlaying() 
amarok:                 [lastfm] track type: "ogg" 
amarok:                 BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:                   [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:                 END__: void ScrobblerAdapter::checkScrobble() - Took 0.0001s 
amarok:                 [lastfm] nowPlaying:  "IAMX"  -  "Kingdom of Welcome Addiction"  -  "My Secret Friend (feat. Imogen Heap)" 
amarok:               END__: virtual void ScrobblerAdapter::engineNewTrackPlaying() - Took 0.00038s 
amarok:               BEGIN: virtual void TimecodeObserver::engineNewTrackPlaying() 
amarok:               END__: virtual void TimecodeObserver::engineNewTrackPlaying() - Took 4.1e-05s 
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.00014s 
amarok:               END__: virtual void Amarok::OSD::engineNewTrackPlaying() - Took 0.0027s 
amarok:               BEGIN: virtual void Playlist::Actions::engineNewTrackPlaying() 
amarok:                 BEGIN: void StatusBar::updateTotalPlaylistLength() 
amarok:                 END__: void StatusBar::updateTotalPlaylistLength() - Took 0.00038s 
amarok:                 BEGIN: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() 
amarok:                   BEGIN: void Playlist::PrettyListView::scrollToActiveTrack() 
amarok:                   END__: void Playlist::PrettyListView::scrollToActiveTrack() - Took 0.00082s 
amarok:                 END__: void Playlist::PrettyListView::slotPlaylistActiveTrackChanged() - Took 0.00099s 
amarok:               END__: virtual void Playlist::Actions::engineNewTrackPlaying() - Took 0.0021s 
amarok:               BEGIN: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() 
amarok:               END__: virtual void Amarok::KNotificationBackend::engineNewTrackPlaying() - Took 0.00015s 
amarok:               BEGIN: virtual void SimilarArtistsApplet::engineNewTrackPlaying() 
amarok:                 BEGIN: void Context::Applet::setCollapseOff() 
amarok:                    height: 36 target: -1 m_collapsed: false 
amarok:                 END__: void Context::Applet::setCollapseOff() - Took 0.00014s 
amarok:                 BEGIN: void Context::Applet::setCollapseOff() 
amarok:                    height: 36 target: -1 m_collapsed: false 
amarok:                 END__: void Context::Applet::setCollapseOff() - Took 0.00011s 
amarok:                 BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:                 END__: void ArtistWidget::elideArtistDescription() - Took 0.00083s 
amarok:                 BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:                 END__: void ArtistWidget::elideArtistDescription() - Took 0.00076s 
amarok:                 BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:                 END__: void ArtistWidget::elideArtistDescription() - Took 0.00075s 
amarok:                 BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:                 END__: void ArtistWidget::elideArtistDescription() - Took 0.00092s 
amarok:                 BEGIN: void ArtistWidget::elideArtistDescription() 
amarok:                 END__: void ArtistWidget::elideArtistDescription() - Took 0.00083s 
amarok:               END__: virtual void SimilarArtistsApplet::engineNewTrackPlaying() - Took 0.024s 
amarok:               BEGIN: virtual void Context::ContextView::engineNewTrackPlaying() 
amarok:                 BEGIN: void WikipediaEngine::update() 
amarok:                   BEGIN: bool EngineController::isStream() 
amarok:                   END__: bool EngineController::isStream() - Took 0.0022s 
amarok:                    Same entry requested again. Ignoring. 
amarok:                 END__: void WikipediaEngine::update() - Took 0.0025s 
amarok:                 BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:                   BEGIN: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) 
amarok:                   END__: void ScriptManager::notifyFetchLyrics(const QString&, const QString&) - Took 0.00035s 
amarok:                 END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.00059s 
amarok:                 BEGIN: void UpcomingEventsEngine::update() 
amarok:                   BEGIN: bool EngineController::isStream() 
amarok:                   END__: bool EngineController::isStream() - Took 4.1e-05s 
amarok:                 END__: void UpcomingEventsEngine::update() - Took 0.00022s 
amarok:                 BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:                   BEGIN: void CurrentEngine::update() 
amarok:                   END__: void CurrentEngine::update() - Took 0.00015s 
amarok:                 END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 0.00028s 
amarok:                 BEGIN: bool EngineController::isStream() 
amarok:                 END__: bool EngineController::isStream() - Took 3.9e-05s 
amarok:               END__: virtual void Context::ContextView::engineNewTrackPlaying() - Took 0.0039s 
amarok:             END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.078s 
amarok:             [EngineController] boom? 
amarok:             [EngineController] no boom? 
play 
[0x344f6a8] main input debug: Creating an input for '(null)'
[0x344f6a8] main input debug: thread (input) created at priority 10 (input/input.c:214)
updateVolume Volume changed to -  32  From  32 
amarok:             [EngineController] track pos after play:  0 
amarok:           END__: void EngineController::playUrl(const KUrl&, uint) - Took 0.086s 
amarok:         END__: void EngineController::play(const Meta::TrackPtr&, uint) - Took 0.086s 
amarok:       END__: void EngineController::setNextTrack(Meta::TrackPtr) - Took 0.086s 
amarok:     END__: void Playlist::Actions::play(quint64, bool) - Took 0.086s 
amarok:   END__: void Playlist::Actions::requestNextTrack() - Took 0.086s 
amarok:   BEGIN: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) 
amarok:      State changed, oldState: 1 -> newState: 5 
amarok:     [Playlist::Actions] [WARNING!] Error, can not play this track. 
amarok:     [Playlist::Actions] [WARNING!] Failure count:  4 
amarok:   END__: void Engine::EngineSubject::stateChangedNotify(Phonon::State, Phonon::State) - Took 0.0017s 
amarok: END__: void EngineController::slotStateChanged(Phonon::State, Phonon::State) - Took 0.088s 
amarok: BEGIN: void EngineController::slotQueueEnded() 
[0x35c4d08] main input debug: Creating an input for '(null)'
[0x134f8e8] main playlist debug: no fetch required for (null) (art currently (null))
[0x344f6a8] main input debug: thread started
[0x344f6a8] main input debug: using timeshift granularity of 50 MiB
[0x344f6a8] main input debug: using timeshift path '/tmp'
[0x344f6a8] main input debug: `' gives access `' demux `' path `'
[0x344f6a8] main input debug: creating demux: access='' demux='' path=''
[0x3017208] main demux debug: looking for access_demux module: 14 candidates
[0x3017208] main demux debug: no access_demux module matching "any" could be loaded
[0x344f6a8] main input debug: creating access '' path=''
[0x25eea58] main access debug: looking for access module: 10 candidates
[0x25eea58] filesystem access debug: opening file `'
[0x25eea58] filesystem access error: cannot open file  (No such file or directory)
[0x25eea58] main access error: File reading failed
[0x25eea58] main access error: VLC could not open the file "".
[0x25eea58] filesystem access debug: opening file `'
[0x25eea58] filesystem access error: cannot open file  (No such file or directory)
[0x25eea58] main access error: File reading failed
[0x25eea58] main access error: VLC could not open the file "".
[0x25eea58] main access debug: no access module matching "any" could be loaded
[0x344f6a8] main input debug: thread ended
stateChangedInternal newState: "StoppedState" previousState: "StoppedState" 
setSource 
setSource Error: MediaSource is empty. 
amarok:   BEGIN: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) 
amarok:     [EngineController] Empty MediaSource (engine stop) 
amarok:   END__: void EngineController::slotNewTrackPlaying(const Phonon::MediaSource&) - Took 0.00014s 
amarok:   BEGIN: virtual void ProgressWidget::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: void Amarok::TimeSlider::clearTriangles() 
amarok:        number of triangles:  0 
amarok:        deleted them all... 
amarok:     END__: void Amarok::TimeSlider::clearTriangles() - Took 0.00011s 
amarok:   END__: virtual void ProgressWidget::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00023s 
amarok:   BEGIN: virtual void ScrobblerAdapter::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: void ScrobblerAdapter::checkScrobble() 
amarok:       [lastfm] total played 0 duration 0 isNull false submit? true 
amarok:     END__: void ScrobblerAdapter::checkScrobble() - Took 0.00011s 
amarok:   END__: virtual void ScrobblerAdapter::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00019s 
amarok:   BEGIN: virtual void TimecodeObserver::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:   END__: virtual void TimecodeObserver::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00016s 
amarok:   BEGIN: virtual void Context::ContextView::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) 
amarok:     BEGIN: virtual void LyricsEngine::message(const Context::ContextState&) 
amarok:     END__: virtual void LyricsEngine::message(const Context::ContextState&) - Took 0.00018s 
amarok:     BEGIN: virtual void CurrentEngine::message(const Context::ContextState&) 
amarok:     END__: virtual void CurrentEngine::message(const Context::ContextState&) - Took 0.00011s 
amarok:   END__: virtual void Context::ContextView::enginePlaybackEnded(qint64, qint64, Engine::EngineObserver::PlaybackEndedReason) - Took 0.00066s 
amarok: END__: void EngineController::slotQueueEnded() - Took 0.0096s 
amarok: BEGIN: void UpcomingEventsApplet::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void UpcomingEventsApplet::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.012s 
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.0014s 
amarok: BEGIN: virtual void UpcomingEventsApplet::constraintsEvent(Plasma::Constraints) 
QWidget::setMinimumSize: (/QWidget) Negative sizes (720,-51) are not possible
QWidget::setMaximumSize: (/QWidget) Negative sizes (720,-51) are not possible
amarok: END__: virtual void UpcomingEventsApplet::constraintsEvent(Plasma::Constraints) - Took 0.0033s 
amarok(2792)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://userserve-ak.last.fm/serve/126/30388031.jpg") 
amarok(2792)/kio (KIOJob) KIO::TransferJob::slotMimetype: mimetype() emitted again, or after sending first data!; job URL = KUrl("http://userserve-ak.last.fm/serve/126/16192805.jpg") 
amarok: BEGIN: void AmarokDownloadHelper::resultData(KJob*) 
amarok:   BEGIN: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) 
amarok:   END__: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) - Took 0.00033s 
amarok: END__: void AmarokDownloadHelper::resultData(KJob*) - Took 0.0027s 
amarok: BEGIN: void AmarokDownloadHelper::resultData(KJob*) 
amarok:   BEGIN: void AmarokScript::AmarokLyricsScript::showLyrics(const QString&) const 
amarok:   END__: void AmarokScript::AmarokLyricsScript::showLyrics(const QString&) const - Took 0.00014s 
amarok: END__: void AmarokDownloadHelper::resultData(KJob*) - Took 0.0054s 
amarok: BEGIN: void CurrentEngine::stoppedState() 
amarok: END__: void CurrentEngine::stoppedState() - Took 0.0038s 
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.00065s 
amarok: BEGIN: void CurrentEngine::resultReady(const QString&, const Meta::TrackList&) 
amarok: END__: void CurrentEngine::resultReady(const QString&, const Meta::TrackList&) - Took 0.00034s 
amarok: BEGIN: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) 
amarok: END__: void CurrentTrack::dataUpdated(const QString&, const QHash<QString, QVariant>&) - Took 0.0004s 
amarok(2792) KNetworkAccessManager::createRequest: PostOperation:  QUrl( "http://post.audioscrobbler.com:80/np_1.2" )
HTTP POST:  QUrl( "http://post.audioscrobbler.com:80/np_1.2" )  "s=648b9f362f064534b0b80615b1a87e3b&a=IAMX&t=My%20Secret%20Friend%20%28feat.%20Imogen%20Heap%29&b=Kingdom%20of%20Welcome%20Addiction&l=0&n=0&m=" 
amarok(2792) KNetworkReply::setMimeType: "text/plain"
"OK" 
amarok: BEGIN: void MainWindow::saveLayout() 
amarok: END__: void MainWindow::saveLayout() - Took 0.034s 
amarok: BEGIN: void ScanManager::startIncrementalScan(const QString&) 
amarok:   BEGIN: void ScanManager::checkTables(bool) 
amarok:   END__: void ScanManager::checkTables(bool) - Took 0.00024s 
amarok:   BEGIN: QStringList ScanManager::getDirsToScan() 
amarok:   END__: QStringList ScanManager::getDirsToScan() - Took 0.1s 
amarok:    GOING TO SCAN: 
amarok:    "(a *lot*: 2460 directories)" 
amarok:   BEGIN: void ScanManager::writeBatchIncrementalInfoFile() 
amarok:   END__: void ScanManager::writeBatchIncrementalInfoFile() - Took 0.0038s 
amarok:   BEGIN: XmlParseJob::XmlParseJob(ScanManager*, Collections::SqlCollection*) 
amarok:     BEGIN: ProgressBar* ProgressBar::setAbortSlot(QObject*, const char*, Qt::ConnectionType) 
amarok:        Setting abort slot for  "Scanning music" 
amarok:        connecting to  1abort() 
amarok:     END__: ProgressBar* ProgressBar::setAbortSlot(QObject*, const char*, Qt::ConnectionType) - Took 0.00022s 
amarok:   END__: XmlParseJob::XmlParseJob(ScanManager*, Collections::SqlCollection*) - Took 0.002s 
amarok: END__: void ScanManager::startIncrementalScan(const QString&) - Took 0.12s 
amarok: BEGIN: virtual void XmlParseJob::run() 
amarok:    Success. Committing result to database. 
amarok:    Database temporary table setup did not complete due to no directories needing to be processed. 
amarok: END__: virtual void XmlParseJob::run() - Took 0.13s 
amarok: BEGIN: virtual XmlParseJob::~XmlParseJob() 
amarok:   BEGIN: void StatusBar::hideProgress() 
amarok:   END__: void StatusBar::hideProgress() - Took 0.00059s 
amarok: END__: virtual XmlParseJob::~XmlParseJob() - Took 0.0015s 
amarok: BEGIN: void ScanManager::slotFinished() 
amarok: END__: void ScanManager::slotFinished() - Took 0.00019s 
amarok: BEGIN: void ScanManager::startIncrementalScan(const QString&) 
amarok:   BEGIN: void ScanManager::checkTables(bool) 
amarok:   END__: void ScanManager::checkTables(bool) - Took 0.00026s 
amarok:   BEGIN: QStringList ScanManager::getDirsToScan() 
amarok:   END__: QStringList ScanManager::getDirsToScan() - Took 0.11s 
amarok:    GOING TO SCAN: 
amarok:    "(a *lot*: 2460 directories)" 
amarok:   BEGIN: void ScanManager::writeBatchIncrementalInfoFile() 
amarok:   END__: void ScanManager::writeBatchIncrementalInfoFile() - Took 0.0038s 
amarok:   BEGIN: XmlParseJob::XmlParseJob(ScanManager*, Collections::SqlCollection*) 
amarok:     BEGIN: ProgressBar* ProgressBar::setAbortSlot(QObject*, const char*, Qt::ConnectionType) 
amarok:        Setting abort slot for  "Scanning music" 
amarok:        connecting to  1abort() 
amarok:     END__: ProgressBar* ProgressBar::setAbortSlot(QObject*, const char*, Qt::ConnectionType) - Took 0.00022s 
amarok:   END__: XmlParseJob::XmlParseJob(ScanManager*, Collections::SqlCollection*) - Took 0.002s 
amarok: END__: void ScanManager::startIncrementalScan(const QString&) - Took 0.13s 
amarok: BEGIN: virtual void XmlParseJob::run() 
amarok:    Success. Committing result to database. 
amarok:    Database temporary table setup did not complete due to no directories needing to be processed. 
amarok: END__: virtual void XmlParseJob::run() - Took 0.13s 
amarok: BEGIN: virtual XmlParseJob::~XmlParseJob() 
amarok:   BEGIN: void StatusBar::hideProgress() 
amarok:   END__: void StatusBar::hideProgress() - Took 0.00054s 
amarok: END__: virtual XmlParseJob::~XmlParseJob() - Took 0.0012s 
amarok: BEGIN: void ScanManager::slotFinished() 
amarok: END__: void ScanManager::slotFinished() - Took 0.00022s
Comment 1 Roderick B. Greening 2010-05-22 05:28:52 UTC 
The issue from my perspective is that the CD ROM can be any arbitrary name, dynamically assigned via udev rules. In my case, I had two external CD ROM devices which had been attached at some point, and the first was assigned /dev/cdrom and the second was assigned /dev/cdrom1. When I had plugged in the second one, which now had a persistantr rule for it, Amarok would not play Audio CD's from it. If I manually edited the udev persistant rule to point to /dev/cdrom it would work. The same was true for Kscd.

So, the issue here is that even though Solid uses HAL as a backend for dynamically finding hardware abstractions, and the KIO slave audiocd:/ recognizes whatever udev say my CD ROM is, the applications which really need this dynamic behaviour, instead are locked to only read from /dev/cdrom.
Comment 2 paul.leopardi 2011-08-28 05:46:55 UTC 
With Amarok 2.4.3 on KDE 4.7 using openSUSE 11.3, I see the behaviour described in bug 277550.
Comment 3 Andrew Crouthamel 2018-11-06 15:15:48 UTC 
Dear Bug Submitter,

This bug has been stagnant for a long time. Could you help us out and re-test if the bug is valid in the latest version? I am setting the status to NEEDSINFO pending your response, please change the Status back to REPORTED when you respond.

Thank you for helping us make KDE software even better for everyone!
Comment 4 Andrew Crouthamel 2018-11-18 03:32:09 UTC 
Dear Bug Submitter,

This is a reminder that this bug has been stagnant for a long time. Could you help us out and re-test if the bug is valid in the latest version? This bug will be moved back to REPORTED Status for manual review later, which may take a while. If you are able to, please lend us a hand.

Thank you for helping us make KDE software even better for everyone!