museofficial / muse

🎧 a self-hosted midwestern Discord music bot that doesn't suck
MIT License
880 stars 230 forks source link

/play results in "is thinking..." indefinately #937

Open Merith-TK opened 1 year ago

Merith-TK commented 1 year ago

What's happening? image I did /play https://music.youtube.com/watch?v=3RhHBx_ZtWQ and this happens

Logs

mastodon@talk:~/docker$ docker logs muse
yarn run v1.22.19
$ npm run env:set-database-url -- tsx src/scripts/migrate-and-start.ts
2023-05-05T20:37:11.672Z agentkeepalive sock[0#registry.yarnpkg.com:443::::::::true:::::::::::::] create, timeout 300001ms

> muse@2.2.4 env:set-database-url
> tsx src/scripts/run-with-database-url.ts

2023-05-05T20:37:14.098Z prisma:tryLoadEnv  Environment variables not found at null
2023-05-05T20:37:14.098Z prisma:tryLoadEnv  Environment variables not found at undefined
2023-05-05T20:37:14.098Z prisma:tryLoadEnv  No Environment variables loaded
2023-05-05T20:37:14.543Z prisma:tryLoadEnv  Environment variables not found at null
2023-05-05T20:37:14.543Z prisma:tryLoadEnv  Environment variables not found at undefined
2023-05-05T20:37:14.543Z prisma:tryLoadEnv  No Environment variables loaded
2023-05-05T20:37:14.543Z prisma:client  dirname /usr/app/node_modules/.prisma/client
2023-05-05T20:37:14.543Z prisma:client  relativePath ../../..
2023-05-05T20:37:14.543Z prisma:client  cwd /usr/app
2023-05-05T20:37:14.544Z prisma:client  clientVersion: 4.1.1
2023-05-05T20:37:14.544Z prisma:client  clientEngineType: library
2023-05-05T20:37:14.544Z prisma:client:libraryEngine  internalSetup
2023-05-05T20:37:15.017Z agentkeepalive sock[0#registry.yarnpkg.com:443::::::::true:::::::::::::](requests: 1, finished: 1) free
2023-05-05T20:37:16.030Z prisma:tryLoadEnv  Environment variables not found at null
2023-05-05T20:37:16.030Z prisma:tryLoadEnv  Environment variables not found at undefined
2023-05-05T20:37:16.030Z prisma:tryLoadEnv  No Environment variables loaded
2023-05-05T20:37:16.030Z prisma:client  dirname /usr/app/node_modules/.prisma/client
2023-05-05T20:37:16.030Z prisma:client  relativePath ../../..
2023-05-05T20:37:16.030Z prisma:client  cwd /usr/app
2023-05-05T20:37:16.030Z prisma:client  clientVersion: 4.1.1
2023-05-05T20:37:16.030Z prisma:client  clientEngineType: library
2023-05-05T20:37:16.031Z prisma:client:libraryEngine  internalSetup
========================================
========================================
================= muse =================
========================================
=========== Made with 🎶 by ============
==== https://github.com/codetheweb =====
========================================
========================================

Running version 2.2.4 built on 4/18/2023 (commit b40d072488da292c88a896a1e7f2f5d44a8f2b0f)

🔧 Need help? https://github.com/codetheweb/muse/discussions/new
🐛 Bug? https://github.com/codetheweb/muse/issues/new
✨ New feature? https://github.com/codetheweb/muse/issues/new
☕ Discussion? https://github.com/codetheweb/muse/discussions/new
💰 Help me? https://www.paypal.me/codetheweb https://github.com/sponsors/codetheweb

- Applying database migrations...
2023-05-05T20:37:16.104Z prisma:client  prisma.queryRaw(SELECT COUNT(id) FROM _prisma_migrations, [])
2023-05-05T20:37:16.104Z prisma:client  Prisma Client call:
2023-05-05T20:37:16.161Z prisma:client:libraryEngine:loader  Searching for Query Engine Library in /usr/app/node_modules/.prisma/client
2023-05-05T20:37:16.161Z prisma:client:libraryEngine:loader  loadEngine using /usr/app/node_modules/.prisma/client/libquery_engine-debian-openssl-1.1.x.so.node
2023-05-05T20:37:16.174Z prisma:client  Prisma Client call:
2023-05-05T20:37:16.175Z prisma:client  prisma.$queryRaw({
  query: 'SELECT COUNT(id) FROM _prisma_migrations',
  parameters: {
    values: '[]',
    __prismaRawParamaters__: true
  }
})
2023-05-05T20:37:16.175Z prisma:client  Generated request:
2023-05-05T20:37:16.175Z prisma:client  mutation {
  queryRaw(
    query: "SELECT COUNT(id) FROM _prisma_migrations"
    parameters: "[]"
  )
}

2023-05-05T20:37:16.175Z prisma:client:libraryEngine  sending request, this.libraryStarted: false
2023-05-05T20:37:16.175Z prisma:client:libraryEngine  library starting
2023-05-05T20:37:16.176Z prisma:client:libraryEngine:loader  Searching for Query Engine Library in /usr/app/node_modules/.prisma/client
2023-05-05T20:37:16.176Z prisma:client:libraryEngine:loader  loadEngine using /usr/app/node_modules/.prisma/client/libquery_engine-debian-openssl-1.1.x.so.node
2023-05-05T20:37:16.177Z prisma:client:libraryEngine  library started
✔ Database migrations applied.
2023-05-05T20:37:16.782Z prisma:client  Prisma Client call:
2023-05-05T20:37:16.783Z prisma:client  prisma.fileCache.findMany({
  where: undefined,
  orderBy: {
    createdAt: 'asc'
  },
  take: 50
})
2023-05-05T20:37:16.783Z prisma:client  Generated request:
2023-05-05T20:37:16.783Z prisma:client  query {
  findManyFileCache(
    orderBy: [
      {
        createdAt: asc
      }
    ]
    take: 50
  ) {
    hash
    bytes
    accessedAt
    createdAt
    updatedAt
  }
}

2023-05-05T20:37:16.783Z prisma:client:libraryEngine  sending request, this.libraryStarted: false
2023-05-05T20:37:16.783Z prisma:client:libraryEngine  library starting
2023-05-05T20:37:16.784Z prisma:client:libraryEngine  library started
2023-05-05T20:37:16.786Z muse Evicting oldest files...
2023-05-05T20:37:16.786Z prisma:client  Prisma Client call:
2023-05-05T20:37:16.787Z prisma:client  prisma.fileCache.aggregate({
  select: {
    _sum: {
      select: {
        bytes: true
      }
    }
  }
})
2023-05-05T20:37:16.787Z prisma:client  Generated request:
2023-05-05T20:37:16.787Z prisma:client  query {
  aggregateFileCache {
    _sum {
      bytes
    }
  }
}

2023-05-05T20:37:16.787Z prisma:client:libraryEngine  sending request, this.libraryStarted: true
2023-05-05T20:37:16.802Z superagent POST https://accounts.spotify.com/api/token
2023-05-05T20:37:16.806Z superagent POST https://accounts.spotify.com/api/token
- 📡 connecting to Discord...
2023-05-05T20:37:16.808Z muse Provided token: ODk2NTk5MTg1ODI1MTAzOTIz.GlqR32.**************************************
2023-05-05T20:37:16.809Z muse Preparing to connect to the gateway...
2023-05-05T20:37:16.815Z muse No files needed to be evicted. Total size of the cache is currently 0 bytes, and the cache limit is 2000000000 bytes.
2023-05-05T20:37:20.174Z muse [WS => Manager] Fetched Gateway Information
    URL: wss://gateway.discord.gg
    Recommended Shards: 1
2023-05-05T20:37:20.174Z muse [WS => Manager] Session Limit Information
    Total: 1000
    Remaining: 996
2023-05-05T20:37:20.174Z muse [WS => Manager] Spawning shards: 0
2023-05-05T20:37:20.175Z muse [WS => Shard 0] [CONNECT]
    Gateway    : wss://gateway.discord.gg/
    Version    : 10
    Encoding   : json
    Compression: none
2023-05-05T20:37:20.175Z muse [WS => Shard 0] Setting a HELLO timeout for 20s.
2023-05-05T20:37:23.475Z muse [WS => Shard 0] [CONNECTED] Took 3300ms
2023-05-05T20:37:23.476Z muse [WS => Shard 0] Clearing the HELLO timeout.
2023-05-05T20:37:23.476Z muse [WS => Shard 0] Setting a heartbeat interval for 41250ms.
2023-05-05T20:37:23.476Z muse [WS => Shard 0] [IDENTIFY] Shard 0/1 with intents: 1153
2023-05-05T20:37:23.573Z muse [WS => Shard 0] [READY] Session 76fb5007091651d705b1e9c2b9a993eb.
2023-05-05T20:37:23.573Z muse [WS => Shard 0] [ReadyHeartbeat] Sending a heartbeat.
2023-05-05T20:37:23.607Z muse [WS => Shard 0] Shard received all its guilds. Marking as fully ready.
2023-05-05T20:37:23.609Z muse --------------------------------------------------
Core Dependencies
- @discordjs/voice: 0.11.0
- prism-media: 1.3.4

Opus Libraries
- @discordjs/opus: 0.8.0
- opusscript: not found

Encryption Libraries
- sodium-native: not found
- sodium: not found
- libsodium-wrappers: 0.7.10
- tweetnacl: not found

FFmpeg
- version: 4.3.5-0+deb11u1
- libopus: yes
--------------------------------------------------
2023-05-05T20:37:23.612Z muse [WS => Shard 0] Heartbeat acknowledged, latency of 39ms.
✔ Ready! Invite the bot with https://<redacted>
2023-05-05T20:37:30.022Z agentkeepalive sock[0#registry.yarnpkg.com:443::::::::true:::::::::::::](requests: 1, finished: 1) timeout after 15000ms, listeners 2, defaultTimeoutListenerCount 3, hasHttpRequest false, HttpRequest timeoutListenerCount 0
2023-05-05T20:37:30.023Z agentkeepalive timeout listeners: onTimeout, onTimeout
2023-05-05T20:37:30.023Z agentkeepalive sock[0#registry.yarnpkg.com:443::::::::true:::::::::::::] is free, destroy quietly
2023-05-05T20:37:30.024Z agentkeepalive sock[0#registry.yarnpkg.com:443::::::::true:::::::::::::](requests: 1, finished: 1) close, isError: false
2023-05-05T20:38:04.727Z muse [WS => Shard 0] [HeartbeatTimer] Sending a heartbeat.
2023-05-05T20:38:04.751Z muse [WS => Shard 0] Heartbeat acknowledged, latency of 24ms.
2023-05-05T20:38:14.470Z prisma:client  Prisma Client call:
2023-05-05T20:38:14.470Z prisma:client  prisma.setting.findUnique({
  where: {
    guildId: '564204797809393665'
  }
})
2023-05-05T20:38:14.470Z prisma:client  Generated request:
2023-05-05T20:38:14.470Z prisma:client  query {
  findUniqueSetting(where: {
    guildId: "564204797809393665"
  }) {
    guildId
    playlistLimit
    secondsToWaitAfterQueueEmpties
    leaveIfNoListeners
    createdAt
    updatedAt
  }
}

2023-05-05T20:38:14.471Z prisma:client:libraryEngine  sending request, this.libraryStarted: true
2023-05-05T20:38:16.265Z prisma:client  Prisma Client call:
2023-05-05T20:38:16.265Z prisma:client  prisma.keyValueCache.findUnique({
  where: {
    key: '[{"searchParams":{"part":"id, snippet, contentDetails","id":"3RhHBx_ZtWQ"}}]'
  }
})
2023-05-05T20:38:16.265Z prisma:client  Generated request:
2023-05-05T20:38:16.265Z prisma:client  query {
  findUniqueKeyValueCache(where: {
    key: "[{\"searchParams\":{\"part\":\"id, snippet, contentDetails\",\"id\":\"3RhHBx_ZtWQ\"}}]"
  }) {
    key
    value
    expiresAt
    createdAt
    updatedAt
  }
}

2023-05-05T20:38:16.265Z prisma:client:libraryEngine  sending request, this.libraryStarted: true
2023-05-05T20:38:16.266Z muse Cache miss: [{"searchParams":{"part":"id, snippet, contentDetails","id":"3RhHBx_ZtWQ"}}]
2023-05-05T20:38:45.978Z muse [WS => Shard 0] [HeartbeatTimer] Sending a heartbeat.
2023-05-05T20:38:46.002Z muse [WS => Shard 0] Heartbeat acknowledged, latency of 24ms.
2023-05-05T20:39:27.229Z muse [WS => Shard 0] [HeartbeatTimer] Sending a heartbeat.
2023-05-05T20:39:27.261Z muse [WS => Shard 0] Heartbeat acknowledged, latency of 32ms.

Screenshots If applicable, add screenshots to help explain your problem.

Additional context Unable to obtain spotify client ID, no "add new client" option shown here is my compose config

  muse:
    image: codetheweb/muse:latest
    container_name: muse
    restart: always
    volumes:
      - ./muse:/data
    environment:
      DISCORD_TOKEN: "<redacted>"
      YOUTUBE_API_KEY: "<redacted>"
      SPOTIFY_CLIENT_ID: ""
      SPOTIFY_CLIENT_SECRET: ""

      DEBUG: "true"

Runtime I'm running Muse:

Versions

codetheweb commented 1 year ago

Just to confirm, you invited Muse to your server with the logged invite URL? I would try kicking Muse and re-inviting, based on the logs it seems like your Muse instance never gets the request from Discord.

Merith-TK commented 1 year ago

I did invite using the invite URL yes,

even made a new Voice and Text channel with @ everyone perms to test

codetheweb commented 1 year ago

Hmm, are you able to invite Muse to a fresh server just to see if it's an issue with your particular server?