search

lavalink-devs / Lavalink

Standalone audio sending node based on Lavaplayer.
https://lavalink.dev/
MIT License
1.57k stars 667 forks source link

No sound send by Lavalink #435

Closed harrrson closed 3 years ago

harrrson commented 3 years ago

After joining channel, Lavalink client does not send sound to bot instance. It was working, until i restarted VPS with bot still connected to channel. Updating library, changing from lavalink.py library to wavelink.py, changing versions of jre to 11, 13, 15, nothing works. When checking "position" of played songs, the number rises, so music was played, but not send.

Version info

Client used: wavelink.py 0.9.6 lavalink.py 3.1.2

Output of java -version:

java 13.0.2 2020-01-14 (now installed version on developing computer and VPS)
openjdk 15.0.2 2021-01-19 (version installed on raspberry pi)

Version: 45f8de045fdd75034b75c63c410121d8315e6b75-SNAPSHOT Build: 1198 Build time: 12.02.2021 17:52:02 UTC Branch master Commit: 45f8de0 Commit time: 12.02.2021 17:48:44 UTC JVM: 15.0.2 Lavaplayer 1.3.65

freyacodes commented 3 years ago

Post logs

harrrson commented 3 years ago

Logs from Raspberry Pi instance:

2021-02-14 15:24:43.687  INFO 1951 --- [main] lavalink.server.Launcher                 :

       .   _                  _ _       _    __ _ _
      /\\ | | __ ___   ____ _| (_)_ __ | | __\ \ \ \
     ( ( )| |/ _` \ \ / / _` | | | '_ \| |/ / \ \ \ \
      \\/ | | (_| |\ V / (_| | | | | | |   <   ) ) ) )
       '  |_|\__,_| \_/ \__,_|_|_|_| |_|_|\_\ / / / /
    =========================================/_/_/_/

        Version:        45f8de045fdd75034b75c63c410121d8315e6b75-SNAPSHOT
        Build:          1198
        Build time:     12.02.2021 17:52:02 UTC
        Branch          master
        Commit:         45f8de0
        Commit time:    12.02.2021 17:48:44 UTC
        JVM:            15.0.2
        Lavaplayer      1.3.65

2021-02-14 15:24:44.062  INFO 1951 --- [main] lavalink.server.Launcher                 : Starting Launcher on alarmpi with PID 1951 (/home/alarm/Hexagrid-RPG-bot-v2/lavalink/Lavalink.jar started by alarm in /home/alarm/Hexagrid-RPG-bot-v2/lavalink)
2021-02-14 15:24:44.065  INFO 1951 --- [main] lavalink.server.Launcher                 : No active profile set, falling back to default profiles: default
2021-02-14 15:24:44.488  WARN 1951 --- [background-preinit] o.s.h.c.j.Jackson2ObjectMapperBuilder    : For Jackson Kotlin classes support please add "com.fasterxml.jackson.module:jackson-module-kotlin" to the classpath
2021-02-14 15:24:49.373  WARN 1951 --- [main] io.undertow.websockets.jsr               : UT026010: Buffer pool was not set on WebSocketDeploymentInfo, the default pool will be used
2021-02-14 15:24:49.477  INFO 1951 --- [main] io.undertow.servlet                      : Initializing Spring embedded WebApplicationContext
2021-02-14 15:24:49.478  INFO 1951 --- [main] o.s.web.context.ContextLoader            : Root WebApplicationContext: initialization completed in 5223 ms
2021-02-14 15:24:50.737  WARN 1951 --- [main] l.server.config.SentryConfiguration      : Turning off sentry
2021-02-14 15:24:52.049  INFO 1951 --- [main] c.s.d.l.tools.GarbageCollectionMonitor   : GC monitoring enabled, reporting results every 2 minutes.
2021-02-14 15:24:52.644  INFO 1951 --- [main] lavalink.server.config.KoeConfiguration  : OS: Linux, Arch: arm
2021-02-14 15:24:52.645  WARN 1951 --- [main] lavalink.server.config.KoeConfiguration  : This system and architecture appears to not support native audio sending! GC pauses may cause your bot to stutter during playback.
2021-02-14 15:24:53.648  INFO 1951 --- [main] o.s.s.concurrent.ThreadPoolTaskExecutor  : Initializing ExecutorService 'applicationTaskExecutor'
2021-02-14 15:24:54.913  INFO 1951 --- [main] org.xnio                                 : XNIO version 3.3.8.Final
2021-02-14 15:24:54.950  INFO 1951 --- [main] org.xnio.nio                             : XNIO NIO Implementation Version 3.3.8.Final
2021-02-14 15:24:55.155  INFO 1951 --- [main] o.s.b.w.e.u.UndertowServletWebServer     : Undertow started on port(s) 49237 (http) with context path ''
2021-02-14 15:24:55.168  INFO 1951 --- [main] lavalink.server.Launcher                 : Started Launcher in 13.461 seconds (JVM running for 15.779)
2021-02-14 15:24:55.177  INFO 1951 --- [main] lavalink.server.Launcher                 : You can safely ignore the big red warning about illegal reflection. See https://github.com/Frederikam/Lavalink/issues/295
2021-02-14 15:25:08.932  INFO 1951 --- [XNIO-1 task-1] io.undertow.servlet                      : Initializing Spring DispatcherServlet 'dispatcherServlet'
2021-02-14 15:25:08.933  INFO 1951 --- [XNIO-1 task-1] o.s.web.servlet.DispatcherServlet        : Initializing Servlet 'dispatcherServlet'
2021-02-14 15:25:08.957  INFO 1951 --- [XNIO-1 task-1] o.s.web.servlet.DispatcherServlet        : Completed initialization in 23 ms
2021-02-14 15:25:09.025  INFO 1951 --- [XNIO-1 task-1] l.server.io.HandshakeInterceptorImpl     : Incoming connection from /127.0.0.1:60426
2021-02-14 15:25:09.248  INFO 1951 --- [XNIO-1 task-1] lavalink.server.io.SocketServer          : Connection successfully established from /127.0.0.1:60426
2021-02-14 15:25:09.266 ERROR 1951 --- [pool-1-thread-1] o.h.p.linux.LinuxCentralProcessor        : Couldn't find physical processor count. Assuming 1.
2021-02-14 15:25:09.267 ERROR 1951 --- [pool-1-thread-1] o.h.p.linux.LinuxCentralProcessor        : Couldn't find physical package count. Assuming 1.
2021-02-14 15:25:22.115  INFO 1951 --- [XNIO-1 task-2] l.server.player.AudioLoaderRestHandler   : Got request to load for identifier "ytsearch:https://www.youtube.com/watch?v=5fExpycwIrU"
2021-02-14 15:25:24.497  INFO 1951 --- [lava-daemon-pool-info-loader-2-thread-1] lavalink.server.player.AudioLoader       : Loaded playlist Search results for: https://www.youtube.com/watch?v=5fExpycwIrU
2021-02-14 15:25:25.234  INFO 1951 --- [XNIO-1 I/O-2] lavalink.server.io.SocketServer          : {"op": "play", "guildId": "733735721386377287", "track": "QAAAmwIALEFNQVJBTlRIRSAtIEFyY2hhbmdlbCAoT0ZGSUNJQUwgTVVTSUMgVklERU8pABVOdWNsZWFyIEJsYXN0IFJlY29yZHMAAAAAAANH2AALNWZFeHB5Y3dJclUAAQAraHR0cHM6Ly93d3cueW91dHViZS5jb20vd2F0Y2g/dj01ZkV4cHljd0lyVQAHeW91dHViZQAAAAAAAAAA", "noReplace": false, "startTime": "0"}
2021-02-14 15:26:40.356  INFO 1951 --- [XNIO-1 task-4] l.server.player.AudioLoaderRestHandler   : Got request to load for identifier "ytsearch:https://www.youtube.com/watch?v=fTvAUUUQqvM"
2021-02-14 15:26:40.781  INFO 1951 --- [lava-daemon-pool-info-loader-2-thread-1] lavalink.server.player.AudioLoader       : Loaded playlist Search results for: https://www.youtube.com/watch?v=fTvAUUUQqvM
2021-02-14 15:26:41.104  INFO 1951 --- [XNIO-1 I/O-2] lavalink.server.io.SocketServer          : {"op": "play", "guildId": "733735721386377287", "track": "QAAAoQIAOUxvdWlzIGZpeGVzIGJvYXJkIHdoaWxlIGxvc2luZyBtaW5kLCBlYXJucyAxIHN0YXIgcmV2aWV3LgAOTG91aXMgUm9zc21hbm4AAAAAAAvymAALZlR2QVVVVVFxdk0AAQAraHR0cHM6Ly93d3cueW91dHViZS5jb20vd2F0Y2g/dj1mVHZBVVVVUXF2TQAHeW91dHViZQAAAAAAAAAA", "noReplace": false, "startTime": "0"}

Logs from development PC

2021-02-14 16:29:09.194  INFO 7660 --- [main] lavalink.server.Launcher                 : 

       .   _                  _ _       _    __ _ _
      /\\ | | __ ___   ____ _| (_)_ __ | | __\ \ \ \
     ( ( )| |/ _` \ \ / / _` | | | '_ \| |/ / \ \ \ \
      \\/ | | (_| |\ V / (_| | | | | | |   <   ) ) ) )
       '  |_|\__,_| \_/ \__,_|_|_|_| |_|_|\_\ / / / /
    =========================================/_/_/_/

    Version:        45f8de045fdd75034b75c63c410121d8315e6b75-SNAPSHOT
    Build:          1198
    Build time:     12.02.2021 17:52:02 UTC
    Branch          master
    Commit:         45f8de0
    Commit time:    12.02.2021 17:48:44 UTC
    JVM:            13.0.2
    Lavaplayer      1.3.65

2021-02-14 16:29:09.310  INFO 7660 --- [main] lavalink.server.Launcher                 : Starting Launcher on DESKTOP-NPQV53R with PID 7660 (D:\Pycharm\Hexagrid-RPG-bot-v2\lavalink\Lavalink.jar started by petra in D:\Pycharm\Hexagrid-RPG-bot-v2\lavalink)
2021-02-14 16:29:09.311  INFO 7660 --- [main] lavalink.server.Launcher                 : No active profile set, falling back to default profiles: default
2021-02-14 16:29:09.436  WARN 7660 --- [background-preinit] o.s.h.c.j.Jackson2ObjectMapperBuilder    : For Jackson Kotlin classes support please add "com.fasterxml.jackson.module:jackson-module-kotlin" to the classpath
2021-02-14 16:29:11.147  WARN 7660 --- [main] io.undertow.websockets.jsr               : UT026010: Buffer pool was not set on WebSocketDeploymentInfo, the default pool will be used
2021-02-14 16:29:11.173  INFO 7660 --- [main] io.undertow.servlet                      : Initializing Spring embedded WebApplicationContext
2021-02-14 16:29:11.174  INFO 7660 --- [main] o.s.web.context.ContextLoader            : Root WebApplicationContext: initialization completed in 1794 ms
2021-02-14 16:29:11.578  WARN 7660 --- [main] l.server.config.SentryConfiguration      : Turning off sentry
2021-02-14 16:29:11.886  INFO 7660 --- [main] c.s.d.l.tools.GarbageCollectionMonitor   : GC monitoring enabled, reporting results every 2 minutes.
2021-02-14 16:29:12.439  INFO 7660 --- [main] lavalink.server.config.KoeConfiguration  : OS: Windows 10, Arch: amd64
2021-02-14 16:29:12.440  WARN 7660 --- [main] lavalink.server.config.KoeConfiguration  : This system and architecture appears to not support native audio sending! GC pauses may cause your bot to stutter during playback.
2021-02-14 16:29:12.749  INFO 7660 --- [main] o.s.s.concurrent.ThreadPoolTaskExecutor  : Initializing ExecutorService 'applicationTaskExecutor'
2021-02-14 16:29:13.093  INFO 7660 --- [main] org.xnio                                 : XNIO version 3.3.8.Final
2021-02-14 16:29:13.109  INFO 7660 --- [main] org.xnio.nio                             : XNIO NIO Implementation Version 3.3.8.Final
2021-02-14 16:29:13.186  INFO 7660 --- [main] o.s.b.w.e.u.UndertowServletWebServer     : Undertow started on port(s) 49237 (http) with context path ''
2021-02-14 16:29:13.192  INFO 7660 --- [main] lavalink.server.Launcher                 : Started Launcher in 4.542 seconds (JVM running for 5.152)
2021-02-14 16:29:13.194  INFO 7660 --- [main] lavalink.server.Launcher                 : You can safely ignore the big red warning about illegal reflection. See https://github.com/Frederikam/Lavalink/issues/295
2021-02-14 16:29:41.065  INFO 7660 --- [XNIO-1 task-1] io.undertow.servlet                      : Initializing Spring DispatcherServlet 'dispatcherServlet'
2021-02-14 16:29:41.066  INFO 7660 --- [XNIO-1 task-1] o.s.web.servlet.DispatcherServlet        : Initializing Servlet 'dispatcherServlet'
2021-02-14 16:29:41.075  INFO 7660 --- [XNIO-1 task-1] o.s.web.servlet.DispatcherServlet        : Completed initialization in 8 ms
2021-02-14 16:29:41.104  INFO 7660 --- [XNIO-1 task-1] l.server.io.HandshakeInterceptorImpl     : Incoming connection from /127.0.0.1:57603
2021-02-14 16:29:41.175  INFO 7660 --- [XNIO-1 task-1] lavalink.server.io.SocketServer          : Connection successfully established from /127.0.0.1:57603
2021-02-14 16:31:04.591  INFO 7660 --- [XNIO-1 task-2] l.server.player.AudioLoaderRestHandler   : Got request to load for identifier "ytsearch:https://www.youtube.com/watch?v=5fExpycwIrU"
2021-02-14 16:31:05.920  INFO 7660 --- [lava-daemon-pool-info-loader-2-thread-1] lavalink.server.player.AudioLoader       : Loaded playlist Search results for: https://www.youtube.com/watch?v=5fExpycwIrU
2021-02-14 16:31:06.521  INFO 7660 --- [XNIO-1 I/O-7] lavalink.server.io.SocketServer          : {"op": "play", "guildId": "733735721386377287", "track": "QAAAmwIALEFNQVJBTlRIRSAtIEFyY2hhbmdlbCAoT0ZGSUNJQUwgTVVTSUMgVklERU8pABVOdWNsZWFyIEJsYXN0IFJlY29yZHMAAAAAAANH2AALNWZFeHB5Y3dJclUAAQAraHR0cHM6Ly93d3cueW91dHViZS5jb20vd2F0Y2g/dj01ZkV4cHljd0lyVQAHeW91dHViZQAAAAAAAAAA", "noReplace": false, "startTime": "0"}
2021-02-14 16:31:40.463  INFO 7660 --- [XNIO-1 task-4] l.server.player.AudioLoaderRestHandler   : Got request to load for identifier "ytsearch:https://www.youtube.com/watch?v=fTvAUUUQqvM"
2021-02-14 16:31:40.840  INFO 7660 --- [lava-daemon-pool-info-loader-2-thread-1] lavalink.server.player.AudioLoader       : Loaded playlist Search results for: https://www.youtube.com/watch?v=fTvAUUUQqvM
2021-02-14 16:31:41.196  INFO 7660 --- [XNIO-1 I/O-7] lavalink.server.io.SocketServer          : {"op": "play", "guildId": "733735721386377287", "track": "QAAAoQIAOUxvdWlzIGZpeGVzIGJvYXJkIHdoaWxlIGxvc2luZyBtaW5kLCBlYXJucyAxIHN0YXIgcmV2aWV3LgAOTG91aXMgUm9zc21hbm4AAAAAAAvymAALZlR2QVVVVVFxdk0AAQAraHR0cHM6Ly93d3cueW91dHViZS5jb20vd2F0Y2g/dj1mVHZBVVVVUXF2TQAHeW91dHViZQAAAAAAAAAA", "noReplace": false, "startTime": "0"}

Player did not send any errors, library too.

freyacodes commented 3 years ago

Your client is never sending the voiceUpdate op, so it never actually connects to the voice server.