• Categories
    • Recent
    • Tags
    • Popular
    • Users
    • Groups
    • Register
    • Login

    Randomly playing end of previously played track

    Scheduled Pinned Locked Moved
    Technical Help
    2
    18
    358
    Loading More Posts
    • Oldest to Newest
    • Newest to Oldest
    • Most Votes
    Reply
    • Reply as topic
    Log in to reply
    This topic has been deleted. Only users with topic management privileges can see it.
    • M
      mipper @jonas
      last edited by

      @jonas Screenshot from 2024-10-04 07-59-35.png

      jonasJ 1 Reply Last reply Reply Quote 0
      • jonasJ
        jonas @mipper
        last edited by

        @mipper
        Maybe it's happening only when switching between MP3 and Ogg Vorbis songs, I'll try to reproduce it.

        jonasJ 1 Reply Last reply Reply Quote 0
        • jonasJ
          jonas @jonas
          last edited by

          I could not reproduce this.
          Maye this is the same bug as https://github.com/strawberrymusicplayer/strawberry/issues/1535?

          M 1 Reply Last reply Reply Quote 0
          • M
            mipper @jonas
            last edited by

            @jonas I don't think it's the same as the linked bug. This issue occurs some time after the song ended. It also repeats over time; the same song ending can be played multiple times with a fair amount of time passing between them, and indeed other songs chipping in in between.

            It looks like the idea of swapping between mp3/ogg may have been a red herring. I've had an example this today which involved only mp3 files.

            Oct  7 09:29:10 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:10.723 DEBUG GstEngine:583                    Stream from URL "file:///srv/Music/T/Temple Of The Dog/1991 - Temple Of The Dog/09 - Four Walled World.mp3" about to end in 12 seconds. Fuge: 1100 + Gap: 12000
Oct  7 09:29:10 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:10.740 DEBUG GstEngine:1128                   Got stream info for "file:///srv/Music/L/lostprophets/2012%20-%20Weapons/10%20-%20Can't%20Get%20Enough.mp3:" "MPEG"
Oct  7 09:29:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:18.252 DEBUG GstEnginePipeline:1387           Stream from URL "file:///srv/Music/T/Temple%20Of%20The%20Dog/1991%20-%20Temple%20Of%20The%20Dog/09%20-%20Four%20Walled%20World.mp3" about to finish.
Oct  7 09:29:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:18.252 DEBUG GstEnginePipeline:2143           Setting next URL to "file:///srv/Music/L/lostprophets/2012%20-%20Weapons/10%20-%20Can't%20Get%20Enough.mp3"
Oct  7 09:29:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:18.274 INFO  GstEnginePipeline:1565           Ignoring error 4536 12 "Your GStreamer installation is missing a plug-in." "../gst/playback/gsturidecodebin.c(1027): no_more_pads_full (): /GstPlayBin:pipeline-2-pipeline/GstURIDecodeBin:uridecodebin11:\nno suitable plugins found:\n../gst/playback/gstdecodebin2.c(4701): gst_decode_bin_expose (): /GstPlayBin:pipeline-2-pipeline/GstURIDecodeBin:uridecodebin11/GstDecodeBin:decodebin13:\nno suitable plugins found:\nMissing decoder: MPEG-1 Layer 3 (MP3) (audio/mpeg, mpegversion=(int)1, mpegaudioversion=(int)1, layer=(int)3, rate=(int)44100, channels=(int)2, parsed=(boolean)true)\n" when loading next track
Oct  7 09:29:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:18.359 INFO  GstEnginePipeline:1565           Ignoring error 4536 12 "Your GStreamer installation is missing a plug-in." "../gst/playback/gsturidecodebin.c(1027): no_more_pads_full (): /GstPlayBin:pipeline-2-pipeline/GstURIDecodeBin:uridecodebin11:\nno suitable plugins found:\n../gst/playback/gstdecodebin2.c(4701): gst_decode_bin_expose (): /GstPlayBin:pipeline-2-pipeline/GstURIDecodeBin:uridecodebin11/GstDecodeBin:decodebin13:\nno suitable plugins found:\nMissing decoder: MPEG-1 Layer 3 (MP3) (audio/mpeg, mpegversion=(int)1, mpegaudioversion=(int)1, layer=(int)3, rate=(int)44100, channels=(int)2, parsed=(boolean)true)\n" when loading next track
Oct  7 09:29:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:18.359 INFO  GstEnginePipeline:1565           Ignoring error 4535 1 "Internal data stream error." "../libs/gst/base/gstbaseparse.c(3681): gst_base_parse_loop (): /GstPlayBin:pipeline-2-pipeline/GstURIDecodeBin:uridecodebin11/GstDecodeBin:decodebin13/GstMpegAudioParse:mpegaudioparse167:\nstreaming stopped, reason not-linked (-1)" when loading next track
Oct  7 09:29:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:18.360 INFO  GstEnginePipeline:1565           Ignoring error 4535 1 "Internal data stream error." "../libs/gst/base/gstbaseparse.c(3681): gst_base_parse_loop (): /GstPlayBin:pipeline-2-pipeline/GstURIDecodeBin:uridecodebin11/GstDecodeBin:decodebin13/GstMpegAudioParse:mpegaudioparse167:\nstreaming stopped, reason not-linked (-1)" when loading next track
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.527 DEBUG GstEnginePipeline:181            Pipeline 2 deleted
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.527 DEBUG MainWindow:1467                  Song changed to "lostprophets" "Weapons" "Can't Get Enough"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.537 INFO  MoodbarLoader:175                Creating moodbar data for "/srv/Music/L/lostprophets/2012 - Weapons/10 - Can't Get Enough.mp3"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.537 DEBUG HtmlLyricsProvider:75            "songlyrics.com" Sending request for QUrl("https://www.songlyrics.com/lostprophets/can-t-get-enough-lyrics/")
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.539 DEBUG Player:836                       Playing song "Can't Get Enough" QUrl("file:///srv/Music/L/lostprophets/2012 - Weapons/10 - Can't Get Enough.mp3") position 0
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.539 DEBUG GstEnginePipeline:639            "pulsesink" has volume, enabling volume synchronization.
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.539 DEBUG GstEnginePipeline:955            Connecting volume notify on 0x5e2eaafec7b0
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.539 DEBUG GstEnginePipeline:810            Setting buffer duration: 4000000000 low watermark: 0.33 high watermark: 0.99
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.539 DEBUG GstEnginePipeline:1831           Setting pipeline 3 state to "Paused"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.539 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Null" to "Ready"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.545 DEBUG GstEnginePipeline:1852           Pipeline 3 state successfully set to "Paused"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.558 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Null" to "Ready"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.567 DEBUG GstEnginePipeline:1767           Buffering started
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.577 DEBUG CollectionModel:547              Container key for 465 "Temple Of The Dog - Four Walled World" is uchanged, only updating song metadata.
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.578 DEBUG GstEngine:1128                   Got stream info for "file:///srv/Music/L/lostprophets/2012%20-%20Weapons/10%20-%20Can't%20Get%20Enough.mp3:" "MPEG"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.598 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Ready" to "Paused"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.598 DEBUG GstEnginePipeline:1689           Pipeline is active
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.598 DEBUG CollectionModel:633              Song metadata for 465 "Temple Of The Dog - Four Walled World" changed
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.602 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Ready" to "Paused"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.605 DEBUG GstEnginePipeline:1778           Buffering finished
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.605 DEBUG GstEnginePipeline:1831           Setting pipeline 3 state to "Playing"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.605 DEBUG GstEnginePipeline:980            3 event latency
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.605 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 09:29:22 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:22.606 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 09:29:23 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:23.065 INFO  MoodbarLoader:188                Moodbar data generated successfully for "/srv/Music/L/lostprophets/2012 - Weapons/10 - Can't Get Enough.mp3"
Oct  7 09:29:23 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:23.423 DEBUG PlaylistBackend:339              Saving playlist 1
Oct  7 09:29:23 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:23.522 DEBUG HtmlLyricsProvider:119           "songlyrics.com" Got lyrics for "lostprophets" "Weapons" "Can't Get Enough"
Oct  7 09:29:23 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:23.522 DEBUG LyricsFetcherSearch:136          Using lyrics from "songlyrics.com" for "lostprophets" "Can't Get Enough" with score -0.5
Oct  7 09:29:43 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:43.864 DEBUG GstEnginePipeline:1831           Setting pipeline 3 state to "Paused"
Oct  7 09:29:43 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:43.865 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 09:29:43 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:43.870 DEBUG GstEnginePipeline:1852           Pipeline 3 state successfully set to "Paused"
Oct  7 09:29:43 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:29:43.872 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 09:57:57 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:57:57.293 DEBUG GstEnginePipeline:1831           Setting pipeline 3 state to "Playing"
Oct  7 09:57:57 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:57:57.294 DEBUG GstEnginePipeline:980            3 event latency
Oct  7 09:57:57 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:57:57.295 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 09:57:57 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:57:57.298 DEBUG GstEnginePipeline:1852           Pipeline 3 state successfully set to "Playing"
Oct  7 09:57:57 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 09:57:57.300 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 10:02:25 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 10:02:25.223 DEBUG GstEngine:583                    Stream from URL "file:///srv/Music/L/lostprophets/2012 - Weapons/10 - Can't Get Enough.mp3" about to end in 12 seconds. Fuge: 1100 + Gap: 120

            But I have a new theory. I believe the example above occurred when I restarted playback this morning. Temple of the Dog was playing as I put my machine to sleep on Friday night with playback paused. This morning when I restarted we saw the issue. My theory now is the exception we're seeing is somehow connected to periods where the player is unpaused after being paused for some kind of extended period.

            M 1 Reply Last reply Reply Quote 0
            • M
              mipper @mipper
              last edited by

              I'm almost sure being on pause for an extended period is causing this. I have just come back from lunch and restarted playback. Boom! Got the missing plugin error and it's left the file that was playing and the next file open. I paused the track at 12:14:13 and restarted at 12:51:11 so around 36 minutes between those two events.

              Now, if I remember correctly, when I restarted playback I also reset the song back to the begining. In fact, looking at the logs, I may have paused the track again shortly after resetting it. Can't be sure but maybe you can tell from the logs:

              Oct  7 12:14:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:14:13.465 DEBUG GstEnginePipeline:1852           Pipeline 3 state successfully set to "Paused"
Oct  7 12:14:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:14:13.467 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 12:51:11 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:11.587 DEBUG GstEnginePipeline:1831           Setting pipeline 3 state to "Playing"
Oct  7 12:51:11 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:11.589 DEBUG GstEnginePipeline:980            3 event latency
Oct  7 12:51:11 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:11.589 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 12:51:11 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:11.594 DEBUG GstEnginePipeline:1852           Pipeline 3 state successfully set to "Playing"
Oct  7 12:51:11 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:11.595 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.980 DEBUG MainWindow:1467                  Song changed to "Trust" "Trust IV" "Par Compromission"
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.981 INFO  MoodbarLoader:139                Loading cached moodbar data for "/srv/Music/T/Trust/1983 - Trust IV/01 - Par Compromission.mp3"
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.981 DEBUG Player:836                       Playing song "Par Compromission" QUrl("file:///srv/Music/T/Trust/1983 - Trust IV/01 - Par Compromission.mp3") position 0
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.990 DEBUG GstEnginePipeline:639            "pulsesink" has volume, enabling volume synchronization.
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.990 DEBUG GstEnginePipeline:955            Connecting volume notify on 0x5e2eaba9ff30
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.991 DEBUG GstEnginePipeline:810            Setting buffer duration: 4000000000 low watermark: 0.33 high watermark: 0.99
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.992 DEBUG GstEnginePipeline:388            Finishing pipeline 3
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.992 DEBUG GstEnginePipeline:1831           Setting pipeline 3 state to "Null"
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.993 DEBUG GstEnginePipeline:1831           Setting pipeline 4 state to "Paused"
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.994 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Null" to "Ready"
Oct  7 12:51:13 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:13.997 DEBUG GstEnginePipeline:1852           Pipeline 4 state successfully set to "Paused"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.013 DEBUG GstEnginePipeline:1852           Pipeline 3 state successfully set to "Null"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.013 DEBUG GstEngine:961                    Pipeline 3 finished
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.014 DEBUG GstEnginePipeline:181            Pipeline 3 deleted
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.014 DEBUG GstEngine:986                    1 pipelines are active
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.021 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Null" to "Ready"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.025 DEBUG GstEnginePipeline:1767           Buffering started
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.072 DEBUG GstEngine:1128                   Got stream info for "file:///srv/Music/T/Trust/1983%20-%20Trust%20IV/01%20-%20Par%20Compromission.mp3:" "MPEG"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.073 DEBUG CollectionModel:547              Container key for 601 "Trust - Par Compromission" is uchanged, only updating song metadata.
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.076 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Ready" to "Paused"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.076 DEBUG GstEnginePipeline:1689           Pipeline is active
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.080 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Ready" to "Paused"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.082 DEBUG GstEnginePipeline:1778           Buffering finished
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.082 DEBUG GstEnginePipeline:1831           Setting pipeline 4 state to "Playing"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.082 DEBUG GstEnginePipeline:980            4 event latency
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.082 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.082 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.094 DEBUG CollectionModel:633              Song metadata for 601 "Trust - Par Compromission" changed
Oct  7 12:51:14 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:51:14.923 DEBUG PlaylistBackend:339              Saving playlist 1
Oct  7 12:52:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:52:30.650 DEBUG GstEnginePipeline:1831           Setting pipeline 4 state to "Paused"
Oct  7 12:52:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:52:30.651 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 12:52:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:52:30.653 DEBUG GstEnginePipeline:1852           Pipeline 4 state successfully set to "Paused"
Oct  7 12:52:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 12:52:30.653 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 13:09:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:30.467 DEBUG GstEnginePipeline:1831           Setting pipeline 4 state to "Playing"
Oct  7 13:09:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:30.478 DEBUG GstEnginePipeline:980            4 event latency
Oct  7 13:09:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:30.478 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 13:09:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:30.478 DEBUG GstEnginePipeline:1852           Pipeline 4 state successfully set to "Playing"
Oct  7 13:09:30 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:30.478 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 13:09:54 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:54.172 DEBUG GstEnginePipeline:1831           Setting pipeline 4 state to "Paused"
Oct  7 13:09:54 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:54.173 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 13:09:54 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:54.178 DEBUG GstEnginePipeline:1852           Pipeline 4 state successfully set to "Paused"
Oct  7 13:09:54 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:09:54.181 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Playing" to "Paused"
Oct  7 13:10:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:10:18.808 DEBUG GstEnginePipeline:1831           Setting pipeline 4 state to "Playing"
Oct  7 13:10:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:10:18.809 DEBUG GstEnginePipeline:980            4 event latency
Oct  7 13:10:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:10:18.809 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 13:10:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:10:18.813 DEBUG GstEnginePipeline:1852           Pipeline 4 state successfully set to "Playing"
Oct  7 13:10:18 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:10:18.816 DEBUG GstEnginePipeline:1686           Pipeline state changed from "Paused" to "Playing"
Oct  7 13:12:44 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:12:44.723 DEBUG GstEngine:583                    Stream from URL "file:///srv/Music/T/Trust/1983 - Trust IV/01 - Par Compromission.mp3" about to end in 12 seconds. Fuge: 1100 + Gap: 12000
Oct  7 13:12:44 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:12:44.747 DEBUG GstEngine:1128                   Got stream info for "file:///srv/Music/M/Metallica/2023%20-%2072%20Seasons/11%20-%20Room%20of%20Mirrors.ogg:" "Ogg Vorbis"
Oct  7 13:12:51 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:12:51.680 DEBUG GstEnginePipeline:1387           Stream from URL "file:///srv/Music/T/Trust/1983%20-%20Trust%20IV/01%20-%20Par%20Compromission.mp3" about to finish.
Oct  7 13:12:51 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:12:51.680 DEBUG GstEnginePipeline:2143           Setting next URL to "file:///srv/Music/M/Metallica/2023%20-%2072%20Seasons/11%20-%20Room%20of%20Mirrors.ogg"
Oct  7 13:12:51 sydney org.strawberrymusicplayer.strawberry.desktop[670555]: 13:12:51.754 INFO  GstEnginePipeline:1565           Ignoring error 4536 12 "Your GStreamer installation is missing a plug-in." "../gst/playback/gsturidecodebin.c(1027): no_more_pads_full (): /GstPlayBin:pipeline-4-pipeline/GstURIDecodeBin:uridecodebin56:\nno suitable plugins found:\n../gst/playback/gstdecodebin2.c(4701): gst_decode_bin_expose (): /GstPlayBin:pipeline-4-pipeline/GstURIDecodeBin:uridecodebin56/GstDecodeBin:decodebin58:\nno suitable plugins found:\nMissing decoder: Vorbis (audio/x-vorbis, rate=(int)44100, channels=(int)2, streamheader=(buffer)< 01766f72626973000000000244ac00000000000000e8030000000000b801, 03766f7262697334000000586970682e4f7267206c6962566f72626973204920323032303037303420285265647563

              I'm trying to reproduce the issue by pausing a track for 30 minutes. Will let you know if I succeed.

              M 1 Reply Last reply Reply Quote 0
              • M
                mipper @mipper
                last edited by mipper

                Well I'm struggling to get a repeatable process, I can confirm it continues to happen but I haven't identified the cause. The only common thing is the no suitable plugin error. Something about how that gets handled is leaving the two files open. I'll keep trying to reproduce it.

                jonasJ 1 Reply Last reply Reply Quote 0
                • jonasJ
                  jonas @mipper
                  last edited by

                  @mipper

                  I've set up pipewire and set output to PulseAudio, tested playing for many hours a playlist on repeat containing MP3 and MP4 files, I still can't reproduce this, I've checked that no more than 1 file is open at a time.

                  If cross fading is disabled, it's hard to understand why several files are kept open at the same time.

                  jonasJ 1 Reply Last reply Reply Quote 0
                  • jonasJ
                    jonas @jonas
                    last edited by

                    Do you have any of the features replay gain, ebur128 or bs2b enabled in the backend settings?

                    M 1 Reply Last reply Reply Quote 0
                    • M
                      mipper @jonas
                      last edited by

                      @jonas Apologies. I didn't get any notification that you'd asked other questions so didn't see this until now. Looking at your conversation in #1582 it sounds promising that you may have tracked it down with brilliant help from jirislaby (Kudos, jirislaby. This has been driving me nuts! 🐵 )

                      If I see any further issues after upgrading to a release with the fix in I'll let you know.

                      Many thanks to you both.

                      jonasJ 1 Reply Last reply Reply Quote 0
                      • jonasJ
                        jonas @mipper
                        last edited by

                        @mipper

                        The issue with Strawberry leaving open pipelines which leads to open files should be fixed in version 1.2.1. However the new version won't work on Ubuntu 22.04 as Strawberry now requires a newer Qt version than is available on that Ubuntu version, consider upgrading to Ubuntu 24.04 (Noble).

                        The "Your GStreamer installation is missing a plug-in" error could be a GStreamer bug, maybe a newer GStreamer version solves that.

                        1 Reply Last reply Reply Quote 0
                        • First post
                          Last post
                        Powered by NodeBB | Contributors