Bug 366273

Summary: jamendo streams are played for e while; but stopping immediately
Product: [Applications] amarok Reporter: Hans Adler <had53>
Component: Playback/StreamsAssignee: Amarok Developers <amarok-bugs-dist>
Status: RESOLVED WORKSFORME    
Severity: normal    
Priority: NOR    
Version: 2.8.0   
Target Milestone: 2.9   
Platform: openSUSE   
OS: Linux   
URL: http://www.jamendo.de
Latest Commit: Version Fixed In:
Sentry Crash Report:

Description Hans Adler 2016-07-30 10:47:40 UTC 
Jamendo streams are played for e while; but stopping immediately. Trying to restart, AMAROK doesnt play any stream or mp3 rsp. ogg file.
You must exit or kill amarok and restart.

Reproducible: Always

Steps to Reproduce:
1. Play any Jamendo-file, like http://api.jamendo.com/get2/stream/track/redirect/?id=136007&streamencoding=mp32
2. After some minutes, the play stops immediately
3. Try to yuse the controls; they will not work.
4. End and restart amarok

Actual Results:  
Amarok works well only with a playlist of local files. If you use jamendo streaming files, the error occurs by the time (after some minutes.)


============ start debug info ============
libhd version 21.24 (x86-64) [7688]
using /var/lib/hardware
kernel version is 4.7
----- /proc/cmdline -----
  BOOT_IMAGE=/boot/vmlinuz-4.7.0-5-default root=UUID=1998575c-7225-4da1-acfe-9dafd0e09524 resume=/dev/sda5 splash=silent quiet showopts
----- /proc/cmdline end -----
debug = 0xff7ffff7
probe = 0x15938fcdaa17fcf9fffe (+memory +pci +isapnp +net +floppy +misc +misc.serial +misc.par +misc.floppy +serial +cpu +bios +monitor +mouse +scsi +usb -usb.mods +modem +modem.usb +parallel +parallel.lp +parallel.zip -isa -isa.isdn +isdn +kbd +prom +sbus +int +braille +braille.alva +braille.fhp +braille.ht -ignx11 +sys -bios.vbe -isapnp.old -isapnp.new -isapnp.mod +braille.baum -manual +fb +pppoe -scan +pcmcia +fork -parallel.imm +s390 +cpuemu -sysfs -s390disks +udev +block +block.cdrom +block.part +edd +edd.mod -bios.ddc -bios.fb -bios.mode +input +block.mods +bios.vesa -cpuemu.debug -scsi.noserial +wlan -bios.crc -hal +bios.vram +bios.acpi -bios.ddc.ports=0 +modules.pata -net.eeprom +x86emu=dump -max -lxrc)
shm: attached segment 9240623 at 0x7f76b2c05000
>> hal.1: read hal data
>> floppy.1: get nvram
----- /proc/nvram -----
  Checksum status: valid
Comment 1 Myriam Schweingruber 2016-07-30 11:50:01 UTC 
Which Phonon backend do you use?
Please start amarok from the command line with these arguments:

amarok -d --nofork

and provide the last ca. 100 lines of output when the problem happens.
Comment 2 Hans Adler 2016-09-13 10:38:54 UTC 
amarok: MPRIS2: Album image location is KUrl("http://api.jamendo.com/get2/image/album/redirect/?id=19501&imagesize=100") 
amarok: MPRIS2: New location for width 100 is KUrl("http://api.jamendo.com/get2/image/album/redirect/?id=19501&imagesize=100") 
amarok: [EngineController] slotStateChanged from  Phonon::StoppedState  to  Phonon::PausedState  
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
Calling appendChild() on a null node does nothing.
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
amarok: [WikipediaEngine] Fetching langlinks: KUrl("https://en.wikipedia.org/w/api.php?action=query&prop=langlinks&titles=n.a.o.h.&format=xml&lllimit=100&redirects=1") 
amarok: BEGIN: void LabelsEngine::resultLastFm(const KUrl&, QByteArray, NetworkAccessManagerProxy::Error) 
amarok:   [LabelsEngine] try 2: title is the same, retrying 
amarok:   [LabelsEngine] try 3: artist and title are the same, returning 
amarok: END__: void LabelsEngine::resultLastFm(const KUrl&, QByteArray, NetworkAccessManagerProxy::Error) [Took: 0s] 
amarok: BEGIN: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) 
amarok: END__: static QScriptValue Downloader::init(QScriptContext*, QScriptEngine*, bool) [Took: 0s] 
amarok: [WikipediaEngine] Fetching langlinks: KUrl("https://nl.wikipedia.org/w/api.php?action=query&prop=langlinks&titles=n.a.o.h.&format=xml&lllimit=100&redirects=1") 
amarok: BEGIN: void AmarokScript::AmarokLyricsScript::showLyricsNotFound(const QString&) const 
amarok:   BEGIN: void LyricsManager::lyricsNotFound(const QString&) 
amarok:     BEGIN: bool LyricsManager::showCached() 
amarok:     END__: bool LyricsManager::showCached() [Took: 0.001s] 
amarok:     BEGIN: void LyricsSubject::sendLyricsMessage(const QString&, const QString&) 
amarok:       BEGIN: virtual void LyricsEngine::lyricsMessage(const QString&, const QString&) 
amarok:       END__: virtual void LyricsEngine::lyricsMessage(const QString&, const QString&) [Took: 0s] 
amarok:     END__: void LyricsSubject::sendLyricsMessage(const QString&, const QString&) [Took: 0s] 
amarok:   END__: void LyricsManager::lyricsNotFound(const QString&) [Took: 0.002s] 
amarok: END__: void AmarokScript::AmarokLyricsScript::showLyricsNotFound(const QString&) const [Took: 0.003s] 
amarok: [WikipediaEngine] Fetching langlinks: KUrl("https://fr.wikipedia.org/w/api.php?action=query&prop=langlinks&titles=n.a.o.h.&format=xml&lllimit=100&redirects=1") 
amarok: [WikipediaEngine] Fetching listing: KUrl("https://de.wikipedia.org/w/api.php?action=query&list=search&srsearch=n.a.o.h.&srprop=size&srredirects=1&srlimit=20&format=xml") 
amarok: BEGIN: void WikipediaEnginePrivate::_dataContainerUpdated(const QString&, const Data&) 
amarok: END__: void WikipediaEnginePrivate::_dataContainerUpdated(const QString&, const Data&) [Took: 0s] 
amarok: BEGIN: void WikipediaApplet::dataUpdated(const QString&, const Data&) 
amarok:   [WikipediaApplet] source URL KUrl("https://de.m.wikipedia.org/wiki/Natriumhydroxid") 
amarok: END__: void WikipediaApplet::dataUpdated(const QString&, const Data&) [Took: 0.006s] 
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0s] 
amarok: [SqlRegistry]   albums: 26 (-5) of 1795 cached 
amarok: [SqlRegistry]  artists: 654 (0) of 1066 cached 
amarok: [SqlRegistry]   genres: 1 (-4) of 1052 cached 
amarok: [SqlRegistry]   tracks: 10 (-54) of 15226 cached 
amarok: BEGIN: void EngineController::slotMetaDataChanged() 
amarok:   [EngineController] slotMetaDataChanged() triggered by phonon, but we've already seen exactly the same metadata recently. Ignoring for now. 
amarok: END__: void EngineController::slotMetaDataChanged() [Took: 0.001s] 
amarok: BEGIN: void EngineController::slotAboutToFinish() 
amarok:   BEGIN: void Playlist::Actions::requestNextTrack() 
amarok:     BEGIN: void Playlist::Actions::play(quint64, bool) 
amarok:       BEGIN: void EngineController::setNextTrack(Meta::TrackPtr) 
amarok:         BEGIN: void EngineController::play(Meta::TrackPtr, uint, bool) 
amarok:           BEGIN: void EngineController::stop(bool, bool) 
amarok:             [EngineController] slotTrackFinishedPlaying( "n.a.o.h." - "Insomnia" - "insouciance" , 0.94345 ) 
Aborting aboutToFinish handling. 
amarok:           END__: void EngineController::stop(bool, bool) [Took: 0.022s] 
amarok:           [EngineController] play: bounded is  QObject(0x0)  current "la course monétaire" 
amarok:           [EngineController] Just a normal, boring track... :-P 
amarok:           BEGIN: void EngineController::playUrl(const KUrl&, uint, bool) 
amarok:             [EngineController] URL:  KUrl("http://api.jamendo.com/get2/stream/track/redirect/?id=136009&streamencoding=mp32") "http://api.jamendo.com/get2/stream/track/redirect/?id=136009&streamencoding=mp32" 
amarok:             [EngineController] Offset:  0 
amarok:           END__: void EngineController::playUrl(const KUrl&, uint, bool) [Took: 0.016s] 
amarok:         END__: void EngineController::play(Meta::TrackPtr, uint, bool) [Took: 0.039s] 
amarok:       END__: void EngineController::setNextTrack(Meta::TrackPtr) [Took: 0.039s] 
amarok:     END__: void Playlist::Actions::play(quint64, bool) [Took: 0.039s] 
amarok:   END__: void Playlist::Actions::requestNextTrack() [Took: 0.039s] 
amarok: END__: void EngineController::slotAboutToFinish() [Took: 0.039s] 
amarok: [EngineController] slotStateChanged from  Phonon::PlayingState  to  Phonon::PausedState  
amarok: MPRIS2: Queueing up a PropertiesChanged signal 
amarok: [EngineController] slotTrackLengthChanged( -1 ) 
amarok: BEGIN: void ProgressWidget::redrawBookmarks(const QString*) 
amarok: END__: void ProgressWidget::redrawBookmarks(const QString*) [Took: 0s] 
amarok: [EngineController] slotStateChanged from  Phonon::PausedState  to  Phonon::StoppedState  
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(Meta::TrackPtr, uint, bool) 
amarok:         BEGIN: void EngineController::stop(bool, bool) 
amarok:         END__: void EngineController::stop(bool, bool) [Took: 0.001s] 
amarok:         [EngineController] play: bounded is  QObject(0x0)  current "la course monétaire" 
amarok:         [EngineController] Just a normal, boring track... :-P 
amarok:         BEGIN: void EngineController::playUrl(const KUrl&, uint, bool) 
amarok:           [EngineController] URL:  KUrl("http://api.jamendo.com/get2/stream/track/redirect/?id=136009&streamencoding=mp32") "http://api.jamendo.com/get2/stream/track/redirect/?id=136009&streamencoding=mp32" 
amarok:           [EngineController] Offset:  0 
amarok:         END__: void EngineController::playUrl(const KUrl&, uint, bool) [Took: 0.003s] 
amarok:       END__: void EngineController::play(Meta::TrackPtr, uint, bool) [Took: 0.005s] 
amarok:     END__: void Playlist::Actions::play(quint64, bool) [Took: 0.005s] 
amarok:   END__: void Playlist::Actions::play(const QModelIndex&) [Took: 0.005s] 
amarok: END__: void Playlist::PrettyListView::trackActivated(const QModelIndex&) [Took: 0.006s] 
^[[
Comment 3 Myriam Schweingruber 2017-02-13 18:50:52 UTC 
Still waiting for the Phonon backend and version...