log

May 31 04:09:05 start[421206]: 2023-05-31T08:09:05.483795Z  INFO mockingbird: Mockingbird initializing...
May 31 04:09:05 start[421206]: 2023-05-31T08:09:05.632566Z  INFO start:start_connection{shard_data=[0, 0, 1]}:initialize:boot{shard_info=[ShardId(0), ShardId(1)]}: serenity::client::bridge::gateway::shard_manager: Telling shard queuer to start shard 0
May 31 04:09:05 start[421206]: 2023-05-31T08:09:05.761983Z  INFO run: serenity::client::bridge::gateway::shard_runner: [ShardRunner [0, 1]] Running
May 31 04:09:05 start[421206]: Coggerz is connected!
May 31 04:09:05 start[421206]: 2023-05-31T08:09:05.937355Z  WARN run:recv_event: serenity::model::channel: Unknown ChannelType value: 15
May 31 04:09:54 start[421206]: 2023-05-31T08:09:54.152189Z  INFO runner{config=Config { crypto_mode: Normal, decode_mode: Decrypt, gateway_timeout: Some(10s), preallocated_tracks: 1, driver_retry: Retry { strategy: Backoff(ExponentialBackoff { min: 250ms, max: 10s, jitter: 0.1 }), retry_limit: Some(5) }, driver_timeout: Some(10s) }}: songbird::driver::connection: Connected to: us-central6509.discord.media:443
May 31 04:09:54 start[421206]: 2023-05-31T08:09:54.152304Z  INFO runner{config=Config { crypto_mode: Normal, decode_mode: Decrypt, gateway_timeout: Some(10s), preallocated_tracks: 1, driver_retry: Retry { strategy: Backoff(ExponentialBackoff { min: 250ms, max: 10s, jitter: 0.1 }), retry_limit: Some(5) }, driver_timeout: Some(10s) }}: songbird::driver::connection: WS heartbeat duration 13750ms.
May 31 04:09:57 start[421206]: 2023-05-31T08:09:57.048948Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:09:57 start[421206]: 2023-05-31T08:09:57.048993Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/46ghFVOfgisVzCCcWjZunL?si=fe130d3a52984a5d
May 31 04:10:08 start[421206]: 2023-05-31T08:10:08.259930Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:10:08 start[421206]: 2023-05-31T08:10:08.263260Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("Distorted Blunts"), artist: Some("Reptilian God Mana"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(175s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:10:08 start[421206]: 2023-05-31T08:10:08.460896Z  INFO dispatch: mockingbird::deemix: load time: 0.19748897
May 31 04:10:08 start[421206]: 2023-05-31T08:10:08.461098Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:10:08 start[421206]: 2023-05-31T08:10:08.476004Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 added
May 31 04:10:08 start[421206]: 2023-05-31T08:10:08.476118Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to MICROPHONE
May 31 04:12:45 start[421206]: 2023-05-31T08:12:45.686538Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:12:45 start[421206]: 2023-05-31T08:12:45.686730Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/0hUowX7Gx6GnBGNAZbwTdH?si=60082f476da346eb
May 31 04:12:58 start[421206]: 2023-05-31T08:12:58.067518Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:12:58 start[421206]: 2023-05-31T08:12:58.074478Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("NoClip"), artist: Some("Reptilian God Mana"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(134s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:12:58 start[421206]: 2023-05-31T08:12:58.147385Z  INFO dispatch: mockingbird::deemix: load time: 0.072757401
May 31 04:12:58 start[421206]: 2023-05-31T08:12:58.147594Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:12:58 start[421206]: 2023-05-31T08:12:58.158158Z  INFO runner: songbird::driver::tasks::events: Event state for track 2 added
May 31 04:13:03 start[421206]: 2023-05-31T08:13:03.716024Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:13:03 start[421206]: 2023-05-31T08:13:03.716135Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 175.22s, play_time: 175.22s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: d72e5b66-4b18-4ffc-86bc-7ae238d3b3b2, metadata: Metadata { track: Some("Distorted Blunts"), artist: Some("Reptilian God Mana"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(175s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:13:03 start[421206]: 2023-05-31T08:13:03.716219Z  INFO runner: songbird::tracks::queue: 1 tracks remain.
May 31 04:13:03 start[421206]: 2023-05-31T08:13:03.718252Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 2 removed.
May 31 04:13:03 start[421206]: 2023-05-31T08:13:03.735456Z  INFO runner: songbird::events::store: Firing Play for [0]
May 31 04:13:25 start[421206]: 2023-05-31T08:13:25.648349Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:13:25 start[421206]: 2023-05-31T08:13:25.648515Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/2ceZWGutu07g96oJRuswO6?si=c66bdb33c351415f
May 31 04:13:35 start[421206]: 2023-05-31T08:13:35.738457Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:13:35 start[421206]: 2023-05-31T08:13:35.746164Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("FarmToTable"), artist: Some("Kid Andre"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(193s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:13:35 start[421206]: 2023-05-31T08:13:35.866137Z  INFO dispatch: mockingbird::deemix: load time: 0.119783672
May 31 04:13:35 start[421206]: 2023-05-31T08:13:35.866260Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:13:35 start[421206]: 2023-05-31T08:13:35.875495Z  INFO runner: songbird::driver::tasks::events: Event state for track 2 added
May 31 04:14:15 start[421206]: 2023-05-31T08:14:15.988838Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:14:15 start[421206]: 2023-05-31T08:14:15.988996Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/3Betl8QKZNGcE9YFPBV28M?si=1650f0af2e554e1e
May 31 04:14:27 start[421206]: 2023-05-31T08:14:27.564533Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:14:27 start[421206]: 2023-05-31T08:14:27.569688Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("HereWeGoAgain"), artist: Some("Kid Andre"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(194s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:14:27 start[421206]: 2023-05-31T08:14:27.691679Z  INFO dispatch: mockingbird::deemix: load time: 0.121869073
May 31 04:14:27 start[421206]: 2023-05-31T08:14:27.691849Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:14:27 start[421206]: 2023-05-31T08:14:27.695553Z  INFO runner: songbird::driver::tasks::events: Event state for track 3 added
May 31 04:15:18 start[421206]: 2023-05-31T08:15:18.175924Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:15:18 start[421206]: 2023-05-31T08:15:18.178057Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 134.44s, play_time: 134.44s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 99bc8442-d734-4bba-901a-050eca912c80, metadata: Metadata { track: Some("NoClip"), artist: Some("Reptilian God Mana"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(134s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:15:18 start[421206]: 2023-05-31T08:15:18.178237Z  INFO runner: songbird::tracks::queue: 2 tracks remain.
May 31 04:15:18 start[421206]: 2023-05-31T08:15:18.178601Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 3 removed.
May 31 04:15:18 start[421206]: 2023-05-31T08:15:18.195422Z  INFO runner: songbird::events::store: Firing Play for [1]
May 31 04:17:24 start[421206]: 2023-05-31T08:17:24.457899Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:17:24 start[421206]: 2023-05-31T08:17:24.458035Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/4DyahQp1CSLnVqhDIw3vGS?si=9ab333fd1ac84fc2
May 31 04:17:36 start[421206]: 2023-05-31T08:17:36.707427Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:17:36 start[421206]: 2023-05-31T08:17:36.716220Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("TACKLE"), artist: Some("Joey Trap"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(104s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:17:36 start[421206]: 2023-05-31T08:17:36.841210Z  INFO dispatch: mockingbird::deemix: load time: 0.124746834
May 31 04:17:36 start[421206]: 2023-05-31T08:17:36.841368Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:17:36 start[421206]: 2023-05-31T08:17:36.856028Z  INFO runner: songbird::driver::tasks::events: Event state for track 3 added
May 31 04:18:08 start[421206]: 2023-05-31T08:18:08.610416Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:18:08 start[421206]: 2023-05-31T08:18:08.610583Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/1lUTmmPMAsxZBR2iK9CKDF?si=240ddda8141a4040
May 31 04:18:16 start[421206]: 2023-05-31T08:18:16.536347Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:18:16 start[421206]: 2023-05-31T08:18:16.546235Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("Me Vs Me"), artist: Some("Moneybagg Yo"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(183s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:18:16 start[421206]: 2023-05-31T08:18:16.670293Z  INFO dispatch: mockingbird::deemix: load time: 0.123902648
May 31 04:18:16 start[421206]: 2023-05-31T08:18:16.670478Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:18:16 start[421206]: 2023-05-31T08:18:16.675427Z  INFO runner: songbird::driver::tasks::events: Event state for track 4 added
May 31 04:18:27 start[421206]: 2023-05-31T08:18:27.481996Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:18:27 start[421206]: 2023-05-31T08:18:27.482101Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/0SLhZlfdLXk63W5BeUK7NC?si=7b374f58e1ff4678
May 31 04:18:31 start[421206]: 2023-05-31T08:18:31.576088Z  INFO runner: songbird::events::store: Firing End for [1]
May 31 04:18:31 start[421206]: 2023-05-31T08:18:31.576180Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 193.38s, play_time: 193.38s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 73bacacf-05d1-400f-9371-c926b838047a, metadata: Metadata { track: Some("FarmToTable"), artist: Some("Kid Andre"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(193s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:18:31 start[421206]: 2023-05-31T08:18:31.576257Z  INFO runner: songbird::tracks::queue: 3 tracks remain.
May 31 04:18:31 start[421206]: 2023-05-31T08:18:31.576293Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 of 4 removed.
May 31 04:18:31 start[421206]: 2023-05-31T08:18:31.598512Z  INFO runner: songbird::events::store: Firing Play for [0]
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.306268Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.312365Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("Rinse Repeat"), artist: Some("GYYPS"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(141s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.446665Z  INFO dispatch: mockingbird::deemix: load time: 0.134108888
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.446818Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.455507Z  INFO runner: songbird::driver::tasks::events: Event state for track 4 added
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.945659Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:18:41 start[421206]: 2023-05-31T08:18:41.945719Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/0GFGeF4giiz0wDwq3wavuF?si=989b2d0d2e5e4645
May 31 04:18:55 start[421206]: 2023-05-31T08:18:55.673105Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:18:55 start[421206]: 2023-05-31T08:18:55.679163Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("Bad Friends"), artist: Some("Kofi"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(161s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:18:55 start[421206]: 2023-05-31T08:18:55.794229Z  INFO dispatch: mockingbird::deemix: load time: 0.114921367
May 31 04:18:55 start[421206]: 2023-05-31T08:18:55.794651Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:18:55 start[421206]: 2023-05-31T08:18:55.798489Z  INFO runner: songbird::driver::tasks::events: Event state for track 5 added
May 31 04:19:44 start[421206]: 2023-05-31T08:19:44.536323Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:19:44 start[421206]: 2023-05-31T08:19:44.536558Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 72.94s, play_time: 72.94s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 70e1b446-e634-4aff-a0b9-ba8a5b16e4f3, metadata: Metadata { track: Some("HereWeGoAgain"), artist: Some("Kid Andre"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(194s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:19:44 start[421206]: 2023-05-31T08:19:44.536851Z  INFO runner: songbird::tracks::queue: 4 tracks remain.
May 31 04:19:44 start[421206]: 2023-05-31T08:19:44.541021Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 5 removed.
May 31 04:19:44 start[421206]: 2023-05-31T08:19:44.555474Z  INFO runner: songbird::events::store: Firing Play for [2]
May 31 04:21:28 start[421206]: 2023-05-31T08:21:28.676133Z  INFO runner: songbird::events::store: Firing End for [2]
May 31 04:21:28 start[421206]: 2023-05-31T08:21:28.676300Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 104.12s, play_time: 104.12s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 44ca5890-70d7-460e-ac04-483767892acb, metadata: Metadata { track: Some("TACKLE"), artist: Some("Joey Trap"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(104s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:21:28 start[421206]: 2023-05-31T08:21:28.676530Z  INFO runner: songbird::tracks::queue: 3 tracks remain.
May 31 04:21:28 start[421206]: 2023-05-31T08:21:28.680166Z  INFO runner: songbird::driver::tasks::events: Event state for track 2 of 4 removed.
May 31 04:21:28 start[421206]: 2023-05-31T08:21:28.695449Z  INFO runner: songbird::events::store: Firing Play for [1]
May 31 04:24:32 start[421206]: 2023-05-31T08:24:32.055965Z  INFO runner: songbird::events::store: Firing End for [1]
May 31 04:24:32 start[421206]: 2023-05-31T08:24:32.056131Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 183.36s, play_time: 183.36s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 84ec66f4-b77c-40e0-af50-aa8c66e977b8, metadata: Metadata { track: Some("Me Vs Me"), artist: Some("Moneybagg Yo"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(183s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:24:32 start[421206]: 2023-05-31T08:24:32.056279Z  INFO runner: songbird::tracks::queue: 2 tracks remain.
May 31 04:24:32 start[421206]: 2023-05-31T08:24:32.060507Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 of 3 removed.
May 31 04:24:32 start[421206]: 2023-05-31T08:24:32.075554Z  INFO runner: songbird::events::store: Firing Play for [1]
May 31 04:25:11 start[421206]: 2023-05-31T08:25:11.996155Z  INFO runner: songbird::events::store: Firing End for [1]
May 31 04:25:11 start[421206]: 2023-05-31T08:25:11.996366Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 39.92s, play_time: 39.92s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: ce24df39-2154-4cc4-860e-e0ffb6b68034, metadata: Metadata { track: Some("Rinse Repeat"), artist: Some("GYYPS"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(141s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:25:11 start[421206]: 2023-05-31T08:25:11.996594Z  INFO runner: songbird::tracks::queue: 1 tracks remain.
May 31 04:25:12 start[421206]: 2023-05-31T08:25:11.998342Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 of 2 removed.
May 31 04:25:12 start[421206]: 2023-05-31T08:25:12.015488Z  INFO runner: songbird::events::store: Firing Play for [0]
May 31 04:26:11 start[421206]: 2023-05-31T08:26:11.297618Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:26:11 start[421206]: 2023-05-31T08:26:11.297794Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 59.28s, play_time: 59.28s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 1b11e710-ef46-409b-bbb9-6bd85cde4b76, metadata: Metadata { track: Some("Bad Friends"), artist: Some("Kofi"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(161s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:26:11 start[421206]: 2023-05-31T08:26:11.297947Z  INFO runner: songbird::tracks::queue: 0 tracks remain.
May 31 04:26:11 start[421206]: 2023-05-31T08:26:11.301184Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 1 removed.
May 31 04:26:11 start[421206]: 2023-05-31T08:26:11.375442Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to (empty)
May 31 04:35:11 start[421206]: 2023-05-31T08:35:11.838443Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:35:11 start[421206]: 2023-05-31T08:35:11.841513Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/2bgbFPner3124FFRz1pbW8?si=3344f9805cfa43b3
May 31 04:35:23 start[421206]: 2023-05-31T08:35:23.130074Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:35:23 start[421206]: 2023-05-31T08:35:23.147998Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("Crampin"), artist: Some("Yvncc"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(134s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:35:23 start[421206]: 2023-05-31T08:35:23.272289Z  INFO dispatch: mockingbird::deemix: load time: 0.124126788
May 31 04:35:23 start[421206]: 2023-05-31T08:35:23.272504Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:35:23 start[421206]: 2023-05-31T08:35:23.295591Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 added
May 31 04:35:23 start[421206]: 2023-05-31T08:35:23.295690Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to MICROPHONE
May 31 04:37:38 start[421206]: 2023-05-31T08:37:38.115960Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:37:38 start[421206]: 2023-05-31T08:37:38.116073Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 134.8s, play_time: 134.8s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: d99ba5e2-76d4-43e6-9c56-614bb3b68c53, metadata: Metadata { track: Some("Crampin"), artist: Some("Yvncc"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(134s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:37:38 start[421206]: 2023-05-31T08:37:38.116218Z  INFO runner: songbird::tracks::queue: 0 tracks remain.
May 31 04:37:38 start[421206]: 2023-05-31T08:37:38.117516Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 1 removed.
May 31 04:37:38 start[421206]: 2023-05-31T08:37:38.195437Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to (empty)
May 31 04:38:02 start[421206]: 2023-05-31T08:38:02.566867Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:38:02 start[421206]: 2023-05-31T08:38:02.568371Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/2lWCcsRGAc139jhZDic1OB?si=0eb716c57f4747a2
May 31 04:38:14 start[421206]: 2023-05-31T08:38:14.770412Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:38:14 start[421206]: 2023-05-31T08:38:14.773033Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("Noisy"), artist: Some("Necroez"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(245s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:38:15 start[421206]: 2023-05-31T08:38:15.065915Z  INFO dispatch: mockingbird::deemix: load time: 0.292756785
May 31 04:38:15 start[421206]: 2023-05-31T08:38:15.066096Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:38:15 start[421206]: 2023-05-31T08:38:15.075542Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 added
May 31 04:38:15 start[421206]: 2023-05-31T08:38:15.075602Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to MICROPHONE
May 31 04:42:20 start[421206]: 2023-05-31T08:42:20.915979Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:42:20 start[421206]: 2023-05-31T08:42:20.916161Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 245.82s, play_time: 245.82s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: 74d8a0a5-c9a4-4988-96fe-c683c2148439, metadata: Metadata { track: Some("Noisy"), artist: Some("Necroez"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(245s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:42:20 start[421206]: 2023-05-31T08:42:20.916310Z  INFO runner: songbird::tracks::queue: 0 tracks remain.
May 31 04:42:20 start[421206]: 2023-05-31T08:42:20.918355Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 1 removed.
May 31 04:42:20 start[421206]: 2023-05-31T08:42:20.995597Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to (empty)
May 31 04:42:26 start[421206]: 2023-05-31T08:42:26.213272Z  INFO dispatch:max_pipe_size: mockingbird::deemix: max pipe size: 1048576
May 31 04:42:26 start[421206]: 2023-05-31T08:42:26.215130Z  INFO dispatch: mockingbird::deemix: Running: deemix-stream  https://open.spotify.com/track/59T20gAtquszBtaHCz4glN?si=2d7aadc261994564
May 31 04:42:38 start[421206]: 2023-05-31T08:42:38.969000Z  INFO dispatch: mockingbird::deemix: running ffmpeg
May 31 04:42:38 start[421206]: 2023-05-31T08:42:38.973157Z  INFO dispatch: mockingbird::deemix: deezer metadata Some(Metadata { track: Some("more than comfortably"), artist: Some("Trees"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(177s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None })
May 31 04:42:39 start[421206]: 2023-05-31T08:42:39.121925Z  INFO dispatch: mockingbird::deemix: load time: 0.148584621
May 31 04:42:39 start[421206]: 2023-05-31T08:42:39.122069Z  INFO dispatch: songbird::tracks::queue: Track added to queue.
May 31 04:42:39 start[421206]: 2023-05-31T08:42:39.135477Z  INFO runner: songbird::driver::tasks::events: Event state for track 1 added
May 31 04:42:39 start[421206]: 2023-05-31T08:42:39.135556Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to MICROPHONE
May 31 04:45:36 start[421206]: 2023-05-31T08:45:36.416032Z  INFO runner: songbird::events::store: Firing End for [0]
May 31 04:45:36 start[421206]: 2023-05-31T08:45:36.416162Z  INFO runner: songbird::tracks::queue: Queued track ended: Track([(TrackState { playing: End, volume: 1.0, position: 177.26s, play_time: 177.26s, loops: Finite(0) }, TrackHandle { inner: InnerHandle { command_channel: Sender, seekable: false, uuid: f8a2c043-f4b9-4ea2-8a28-4db15e9e6c19, metadata: Metadata { track: Some("more than comfortably"), artist: Some("Trees"), date: None, channels: Some(2), channel: None, start_time: None, duration: Some(177s), sample_rate: Some(48000), source_url: None, title: None, thumbnail: None }, typemap: "<LOCK>" } })]).
May 31 04:45:36 start[421206]: 2023-05-31T08:45:36.416300Z  INFO runner: songbird::tracks::queue: 0 tracks remain.
May 31 04:45:36 start[421206]: 2023-05-31T08:45:36.417732Z  INFO runner: songbird::driver::tasks::events: Event state for track 0 of 1 removed.
May 31 04:45:36 start[421206]: 2023-05-31T08:45:36.495761Z  INFO runner{evt_rx=Receiver ssrc=751826 heartbeat_interval=13750.0 attempt_idx=1 info=ConnectionInfo { channel_id: Some(ChannelId(942432077712863295)), endpoint: "us-central6509.discord.media:443", guild_id: GuildId(942432077079535656), session_id: "3712b981d4a0fd00e00386823f1e4a72", token: "<secret>", user_id: UserId(461359650496053258) }}:run{interconnect=Interconnect { core: Sender, events: Sender, mixer: Sender }}: songbird::driver::tasks::ws: Changing to (empty)