Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

Failure to play music when reconnecting to server #11

Open
ropc opened this issue May 27, 2020 · 0 comments
Open

Failure to play music when reconnecting to server #11

ropc opened this issue May 27, 2020 · 0 comments
Assignees

Comments

@ropc
Copy link
Owner

ropc commented May 27, 2020

Related log:

meme-bot_1  | 2020-05-27 17:54:13,541 [discord.player] [INFO] [player.py:153]: Preparing to terminate ffmpeg process 2337.
meme-bot_1  | 2020-05-27 17:54:13,542 [discord.player] [INFO] [player.py:165]: ffmpeg process 2337 successfully terminated with return code of 0.
meme-bot_1  | 2020-05-27 17:54:13,542 [memebot] [DEBUG] [player.py:99]: finished playback. event_type: Type.FINISHED was_last_item: False
meme-bot_1  | 2020-05-27 17:54:13,543 [memebot] [DEBUG] [memebot.py:200]: received player event event_type=<Type.FINISHED: 3> item=PlaybackItem(title='Herbie Hancock - Chameleon (FULL VERSION)', url='https://www.youtube.com/watch?v=UbkqE4fpvdI', transaction_id=UUID('fea0effb-3410-4474-a9fb-14780fc69071'), filepath='/tmp/UbkqE4fpvdI.webm', download_url='https://r2---sn-p5qlsnd6.googlevideo.com/videoplayback?expire=1590622326&ei=FqTOXobJD-Kghgam-qmQBQ&ip=3.94.22.104&id=o-AO6Im1lj3QFL-Qs7b-Imq77KauJOpyG9UhHgvZ1umdeY&itag=251&source=youtube&requiressl=yes&mh=wt&mm=31%2C26&mn=sn-p5qlsnd6%2Csn-vgqsknls&ms=au%2Conr&mv=u&mvi=1&pl=22&vprv=1&mime=audio%2Fwebm&gir=yes&clen=15820856&dur=944.961&lmt=1540589019076922&mt=1590600546&fvip=2&keepalive=yes&c=WEB&txp=5511222&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cvprv%2Cmime%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl&lsig=AG3C_xAwRgIhANcRcF7_T81f0SBTVhYdsqFcOF4kSlNzCfc4SJH7p3udAiEAnnzn9AvAHXBDJ2N4qyzDjlk4fSpd-lVh9OJ-F6aD7qo%3D&sig=AOq0QJ8wRgIhAN83NMRLFehxosdb6vYiNUSKJeQN9pvGUA8qI_UqInulAiEAikVenJnX6xg_CHpXLguUZ016xKjZycMlsdZChDCThAg=&ratebypass=yes') from <memebot.player.player.Player object at 0x7fe743478f40>
meme-bot_1  | 2020-05-27 17:54:13,543 [memebot] [DEBUG] [youtube.py:56]: already downloaded /tmp/CKAsoMLq-jo.webm
meme-bot_1  | 2020-05-27 17:54:13,543 [memebot] [INFO] [player.py:83]: gonna play Dax Johnson - Crazy from https://www.youtube.com/watch?v=CKAsoMLq-jo
meme-bot_1  | 2020-05-27 17:54:13,548 [memebot] [DEBUG] [memebot.py:200]: received player event event_type=<Type.STARTED: 2> item=PlaybackItem(title='Dax Johnson - Crazy', url='https://www.youtube.com/watch?v=CKAsoMLq-jo', transaction_id=UUID('221c22ff-3212-40b7-84b9-42b9b2ceff38'), filepath='/tmp/CKAsoMLq-jo.webm', download_url='https://r3---sn-p5qs7n7d.googlevideo.com/videoplayback?expire=1590623450&ei=eqjOXoHFMouwhgbAtZFI&ip=3.94.22.104&id=o-AOqE7GdcMDCqWpJYRY3xjVLcA1VTGzxOLL7W3QOfQiwu&itag=251&source=youtube&requiressl=yes&mh=Lz&mm=31%2C26&mn=sn-p5qs7n7d%2Csn-vgqs7ns7&ms=au%2Conr&mv=u&mvi=2&pl=22&vprv=1&mime=audio%2Fwebm&gir=yes&clen=5082342&dur=276.001&lmt=1576652356566843&mt=1590601425&fvip=3&keepalive=yes&c=WEB&txp=1301222&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cvprv%2Cmime%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl&lsig=AG3C_xAwRQIhAObc0HRvA_6aFHYoOJGqP86K8VNaaqILVOAaFIDni3KbAiAf5WCajQHDLRoYiDciVMzZ6hnskV5Tcv9jfK_Bv5fAbw%3D%3D&sig=AOq0QJ8wRgIhAOlkRWLVKeSkdAaKUfPJKUBIZFSn-meCXKKkanA3uJyEAiEAoPo2djC0Q1t-S4ZWr0akg3-ANsq0b78_RvNohXQBBIM=&ratebypass=yes') from <memebot.player.player.Player object at 0x7fe743478f40>
meme-bot_1  | 2020-05-27 17:54:13,621 [memebot] [INFO] [memebot.py:78]: received message from meme-bot
meme-bot_1  | 2020-05-27 17:54:31,537 [memebot] [INFO] [memebot.py:78]: received message from itslikeroar
meme-bot_1  | 2020-05-27 17:55:57,280 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:56:07,880 [memebot] [INFO] [memebot.py:78]: received message from itslikeroar
meme-bot_1  | 2020-05-27 17:56:08,866 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:56:18,157 [memebot] [INFO] [memebot.py:78]: received message from itslikeroar
meme-bot_1  | 2020-05-27 17:56:20,265 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:56:34,464 [memebot] [INFO] [memebot.py:78]: received message from itslikeroar
meme-bot_1  | 2020-05-27 17:56:48,738 [memebot] [INFO] [memebot.py:78]: received message from itslikeroar
meme-bot_1  | 2020-05-27 17:57:12,037 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:57:20,059 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:57:22,464 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:57:41,404 [memebot] [INFO] [memebot.py:78]: received message from itslikeroar
meme-bot_1  | 2020-05-27 17:58:06,197 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:58:11,224 [memebot] [INFO] [memebot.py:78]: received message from Noon
meme-bot_1  | 2020-05-27 17:58:49,548 [discord.player] [INFO] [player.py:153]: Preparing to terminate ffmpeg process 2355.
meme-bot_1  | 2020-05-27 17:58:49,548 [discord.player] [INFO] [player.py:165]: ffmpeg process 2355 successfully terminated with return code of 0.
meme-bot_1  | 2020-05-27 17:58:49,549 [memebot] [DEBUG] [player.py:99]: finished playback. event_type: Type.FINISHED was_last_item: True
meme-bot_1  | 2020-05-27 17:58:49,549 [memebot] [DEBUG] [memebot.py:200]: received player event event_type=<Type.FINISHED: 3> item=PlaybackItem(title='Dax Johnson - Crazy', url='https://www.youtube.com/watch?v=CKAsoMLq-jo', transaction_id=UUID('221c22ff-3212-40b7-84b9-42b9b2ceff38'), filepath='/tmp/CKAsoMLq-jo.webm', download_url='https://r3---sn-p5qs7n7d.googlevideo.com/videoplayback?expire=1590623450&ei=eqjOXoHFMouwhgbAtZFI&ip=3.94.22.104&id=o-AOqE7GdcMDCqWpJYRY3xjVLcA1VTGzxOLL7W3QOfQiwu&itag=251&source=youtube&requiressl=yes&mh=Lz&mm=31%2C26&mn=sn-p5qs7n7d%2Csn-vgqs7ns7&ms=au%2Conr&mv=u&mvi=2&pl=22&vprv=1&mime=audio%2Fwebm&gir=yes&clen=5082342&dur=276.001&lmt=1576652356566843&mt=1590601425&fvip=3&keepalive=yes&c=WEB&txp=1301222&sparams=expire%2Cei%2Cip%2Cid%2Citag%2Csource%2Crequiressl%2Cvprv%2Cmime%2Cgir%2Cclen%2Cdur%2Clmt&lsparams=mh%2Cmm%2Cmn%2Cms%2Cmv%2Cmvi%2Cpl&lsig=AG3C_xAwRQIhAObc0HRvA_6aFHYoOJGqP86K8VNaaqILVOAaFIDni3KbAiAf5WCajQHDLRoYiDciVMzZ6hnskV5Tcv9jfK_Bv5fAbw%3D%3D&sig=AOq0QJ8wRgIhAOlkRWLVKeSkdAaKUfPJKUBIZFSn-meCXKKkanA3uJyEAiEAoPo2djC0Q1t-S4ZWr0akg3-ANsq0b78_RvNohXQBBIM=&ratebypass=yes') from <memebot.player.player.Player object at 0x7fe743478f40>
meme-bot_1  | 2020-05-27 17:58:49,549 [memebot] [DEBUG] [player.py:75]: nothing in queue for voice_channel: Musicville
meme-bot_1  | 2020-05-27 17:58:55,212 [discord.voice_client] [ERROR] [voice_client.py:260]: Disconnected from voice... Reconnecting in 0.67s.
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/voice_client.py", line 243, in poll_voice_ws
meme-bot_1  |     await self.ws.poll_event()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/gateway.py", line 746, in poll_event
meme-bot_1  |     msg = await asyncio.wait_for(self.recv(), timeout=30.0)
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/tasks.py", line 490, in wait_for
meme-bot_1  |     raise exceptions.TimeoutError()
meme-bot_1  | asyncio.exceptions.TimeoutError
meme-bot_1  | 2020-05-27 17:58:55,902 [discord.voice_client] [INFO] [voice_client.py:166]: The voice handshake is being terminated for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 17:58:55,902 [discord.voice_client] [INFO] [voice_client.py:211]: Connecting to voice...
meme-bot_1  | 2020-05-27 17:58:55,902 [discord.voice_client] [INFO] [voice_client.py:143]: Starting voice handshake...
meme-bot_1  | 2020-05-27 17:59:19,658 [discord.gateway] [WARNING] [gateway.py:84]: Shard ID None has stopped responding to the gateway. Closing and restarting.
meme-bot_1  | 2020-05-27 17:59:21,460 [discord.gateway] [INFO] [gateway.py:474]: Websocket closed with 1006 (), attempting a reconnect.
meme-bot_1  | 2020-05-27 17:59:21,460 [discord.client] [INFO] [client.py:465]: Got a request to RESUME the websocket.
meme-bot_1  | 2020-05-27 17:59:55,936 [discord.voice_client] [INFO] [voice_client.py:166]: The voice handshake is being terminated for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 17:59:55,936 [discord.voice_client] [INFO] [voice_client.py:168]: The voice client has been removed for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 17:59:55,936 [discord.voice_client] [WARNING] [voice_client.py:268]: Could not connect to voice... Retrying...
meme-bot_1  | 2020-05-27 17:59:55,937 [discord.voice_client] [ERROR] [voice_client.py:260]: Disconnected from voice... Reconnecting in 1.53s.
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 827, in transfer_data
meme-bot_1  |     message = await self.read_message()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 895, in read_message
meme-bot_1  |     frame = await self.read_data_frame(max_size=self.max_size)
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 971, in read_data_frame
meme-bot_1  |     frame = await self.read_frame(max_size)
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 1047, in read_frame
meme-bot_1  |     frame = await Frame.read(
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/framing.py", line 105, in read
meme-bot_1  |     data = await reader(2)
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/streams.py", line 723, in readexactly
meme-bot_1  |     await self._wait_for_data('readexactly')
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/streams.py", line 517, in _wait_for_data
meme-bot_1  |     await self._waiter
meme-bot_1  | asyncio.exceptions.CancelledError
meme-bot_1  |
meme-bot_1  | The above exception was the direct cause of the following exception:
meme-bot_1  |
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/gateway.py", line 746, in poll_event
meme-bot_1  |     msg = await asyncio.wait_for(self.recv(), timeout=30.0)
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/tasks.py", line 483, in wait_for
meme-bot_1  |     return fut.result()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 509, in recv
meme-bot_1  |     await self.ensure_open()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 803, in ensure_open
meme-bot_1  |     raise self.connection_closed_exc()
meme-bot_1  | websockets.exceptions.ConnectionClosedError: code = 1006 (connection closed abnormally [internal]), no reason
meme-bot_1  |
meme-bot_1  | The above exception was the direct cause of the following exception:
meme-bot_1  |
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/voice_client.py", line 243, in poll_voice_ws
meme-bot_1  |     await self.ws.poll_event()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/gateway.py", line 749, in poll_event
meme-bot_1  |     raise ConnectionClosed(exc, shard_id=None) from exc
meme-bot_1  | discord.errors.ConnectionClosed: code = 1006 (connection closed abnormally [internal]), no reason
meme-bot_1  | 2020-05-27 17:59:57,472 [discord.voice_client] [INFO] [voice_client.py:166]: The voice handshake is being terminated for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 17:59:57,473 [discord.voice_client] [INFO] [voice_client.py:211]: Connecting to voice...
meme-bot_1  | 2020-05-27 17:59:57,473 [discord.voice_client] [INFO] [voice_client.py:143]: Starting voice handshake...
meme-bot_1  | 2020-05-27 18:00:57,478 [discord.voice_client] [INFO] [voice_client.py:166]: The voice handshake is being terminated for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 18:00:57,478 [discord.voice_client] [INFO] [voice_client.py:168]: The voice client has been removed for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 18:00:57,478 [discord.voice_client] [WARNING] [voice_client.py:268]: Could not connect to voice... Retrying...
meme-bot_1  | 2020-05-27 18:00:57,478 [discord.voice_client] [ERROR] [voice_client.py:260]: Disconnected from voice... Reconnecting in 3.23s.
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 827, in transfer_data
meme-bot_1  |     message = await self.read_message()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 895, in read_message
meme-bot_1  |     frame = await self.read_data_frame(max_size=self.max_size)
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 971, in read_data_frame
meme-bot_1  |     frame = await self.read_frame(max_size)
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 1047, in read_frame
meme-bot_1  |     frame = await Frame.read(
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/framing.py", line 105, in read
meme-bot_1  |     data = await reader(2)
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/streams.py", line 723, in readexactly
meme-bot_1  |     await self._wait_for_data('readexactly')
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/streams.py", line 517, in _wait_for_data
meme-bot_1  |     await self._waiter
meme-bot_1  | asyncio.exceptions.CancelledError
meme-bot_1  |
meme-bot_1  | The above exception was the direct cause of the following exception:
meme-bot_1  |
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/gateway.py", line 746, in poll_event
meme-bot_1  |     msg = await asyncio.wait_for(self.recv(), timeout=30.0)
meme-bot_1  |   File "/usr/local/lib/python3.8/asyncio/tasks.py", line 483, in wait_for
meme-bot_1  |     return fut.result()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 509, in recv
meme-bot_1  |     await self.ensure_open()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/websockets/protocol.py", line 803, in ensure_open
meme-bot_1  |     raise self.connection_closed_exc()
meme-bot_1  | websockets.exceptions.ConnectionClosedError: code = 1006 (connection closed abnormally [internal]), no reason
meme-bot_1  |
meme-bot_1  | The above exception was the direct cause of the following exception:
meme-bot_1  |
meme-bot_1  | Traceback (most recent call last):
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/voice_client.py", line 243, in poll_voice_ws
meme-bot_1  |     await self.ws.poll_event()
meme-bot_1  |   File "/root/.cache/pypoetry/virtualenvs/memebot-0F2CDWIU-py3.8/lib/python3.8/site-packages/discord/gateway.py", line 749, in poll_event
meme-bot_1  |     raise ConnectionClosed(exc, shard_id=None) from exc
meme-bot_1  | discord.errors.ConnectionClosed: code = 1006 (connection closed abnormally [internal]), no reason
meme-bot_1  | 2020-05-27 18:01:00,715 [discord.voice_client] [INFO] [voice_client.py:166]: The voice handshake is being terminated for Channel ID 550850908838166548 (Guild ID 528695672866603030)
meme-bot_1  | 2020-05-27 18:01:00,715 [discord.voice_client] [INFO] [voice_client.py:211]: Connecting to voice...
meme-bot_1  | 2020-05-27 18:01:00,715 [discord.voice_client] [INFO] [voice_client.py:143]: Starting voice handshake...
meme-bot_1  | 2020-05-27 18:01:03,325 [discord.gateway] [INFO] [gateway.py:241]: Created websocket connected to wss://gateway.discord.gg?encoding=json&v=6&compress=zlib-stream
meme-bot_1  | 2020-05-27 18:01:03,331 [discord.gateway] [INFO] [gateway.py:335]: Shard ID None has sent the RESUME payload.
meme-bot_1  | 2020-05-27 18:01:03,351 [discord.gateway] [INFO] [gateway.py:398]: Shard ID None session has been invalidated.
meme-bot_1  | 2020-05-27 18:01:08,356 [discord.gateway] [INFO] [gateway.py:321]: Shard ID None has sent the IDENTIFY payload.
meme-bot_1  | 2020-05-27 18:01:08,556 [discord.gateway] [INFO] [gateway.py:412]: Shard ID None has connected to Gateway: ["gateway-prd-main-qx1t",{"micros":146816,"calls":["discord-sessions-prd-1-61",{"micros":142234,"calls":["start_session",{"micros":138182,"calls":["api-prd-main-us-east1-2pc6",{"micros":122267,"calls":["get_user",{"micros":10148},"add_authorized_ip",{"micros":14551},"get_guilds",{"micros":11989},"coros_wait",{"micros":1}]}]},"guilds_connect",{"micros":2,"calls":[]},"presence_connect",{"micros":2,"calls":[]}]}]}] (Session ID: 750fe764165aca19c7cfb6fe577dc0a6).
meme-bot_1  | 2020-05-27 18:01:10,613 [memebot] [INFO] [memebot.py:74]: We have logged in as meme-bot#7499
meme-bot_1  | 2020-05-27 18:01:10,613 [memebot] [INFO] [memebot.py:97]: setting up voice channels
meme-bot_1  | 2020-05-27 18:01:10,613 [memebot] [DEBUG] [memebot.py:101]: guild 243918972389425152 not found in bot's guilds
meme-bot_1  | 2020-05-27 18:01:10,613 [memebot] [WARNING] [memebot.py:104]: already have player config for guild 528695672866603030
meme-bot_1  | 2020-05-27 18:01:10,614 [memebot] [INFO] [memebot.py:122]: done setting up voice channels
@ropc ropc self-assigned this May 27, 2020
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

1 participant