Skip to content

Dd logs #379

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.

Sign up for GitHub

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

Closed
joshuatam wants to merge 3 commits into from
Closed

Dd logs #379

Show file tree
Hide file tree
Changes from all commits
Commits
Show all changes
3 commits
Select commit Hold shift + click to select a range
385c653
Make error logs log.
LossyDragon Dec 30, 2025
c4d9f75
Init logger in DepotDownloader
LossyDragon Jan 1, 2026
9565c15
correct log level on canceled chunkProcessingJob
joshuatam Jan 1, 2026
File filter

Filter by extension

Filter by extension
Conversations
Failed to load comments.
Loading
Jump to
Jump to file
Failed to load files.
Loading
Diff view
Diff view
16 changes: 7 additions & 9 deletions ...m-depotdownloader/src/main/kotlin/in/dragonbra/javasteam/depotdownloader/CDNClientPool.kt
View file
Open in desktop
Original file line number Diff line number Diff line change
Expand Up @@ -29,7 +29,7 @@ class CDNClientPool(
private val steamSession: Steam3Session,
private val appId: Int,
private val scope: CoroutineScope,
debug: Boolean = false,
private val debug: Boolean = false,
) : AutoCloseable {

private var logger: Logger? = null
Expand All @@ -49,13 +49,11 @@ class CDNClientPool(
init {
cdnClient = Client(steamSession.steamClient)

if (debug) {
logger = LogManager.getLogger(CDNClientPool::class.java)
}
logger = LogManager.getLogger(CDNClientPool::class.java)
}

override fun close() {
logger?.debug("Closing...")
if (debug) logger?.debug("Closing...")

servers.set(emptyList())

Expand Down Expand Up @@ -89,7 +87,7 @@ class CDNClientPool(
nextServer.set(0)

// servers.joinToString(separator = "\n", prefix = "Servers:\n") { "- $it" }
logger?.debug("Found ${weightedCdnServers.size} Servers")
if (debug) logger?.debug("Found ${weightedCdnServers.size} Servers")

if (weightedCdnServers.isEmpty()) {
throw Exception("Failed to retrieve any download servers.")
Expand All @@ -102,7 +100,7 @@ class CDNClientPool(
val index = nextServer.getAndIncrement()
val server = servers[index % servers.size]

logger?.debug("Getting connection $server")
if (debug) logger?.debug("Getting connection $server")

return server
}
Expand All @@ -113,7 +111,7 @@ class CDNClientPool(
return
}

logger?.debug("Returning connection: $server")
if (debug) logger?.debug("Returning connection: $server")

// (SK) nothing to do, maybe remove from ContentServerPenalty?
}
Expand All @@ -124,7 +122,7 @@ class CDNClientPool(
return
}

logger?.debug("Returning broken connection: $server")
if (debug) logger?.debug("Returning broken connection: $server")

val servers = servers.get()
val currentIndex = nextServer.get()
Expand Down
79 changes: 43 additions & 36 deletions ...depotdownloader/src/main/kotlin/in/dragonbra/javasteam/depotdownloader/DepotDownloader.kt
View file
Open in desktop
Original file line number Diff line number Diff line change
Expand Up @@ -49,6 +49,7 @@ import kotlinx.coroutines.awaitAll
import kotlinx.coroutines.cancel
import kotlinx.coroutines.channels.Channel
import kotlinx.coroutines.coroutineScope
import kotlinx.coroutines.delay
import kotlinx.coroutines.ensureActive
import kotlinx.coroutines.flow.MutableSharedFlow
import kotlinx.coroutines.flow.collect
Expand Down Expand Up @@ -232,13 +233,12 @@ class DepotDownloader @JvmOverloads constructor(
// endregion

init {
if (debug) {
logger = LogManager.getLogger(DepotDownloader::class.java)
}
logger = LogManager.getLogger(DepotDownloader::class.java)

steam3 = Steam3Session(steamClient, debug)

logger?.debug("DepotDownloader launched with ${licenses.size} for account")
if (debug) logger?.debug("DepotDownloader launched with ${licenses.size} for account")

licenses.forEach { license ->
if (license.accessToken.toULong() > 0UL) {
steam3!!.packageTokens[license.packageID] = license.accessToken
Expand Down Expand Up @@ -398,14 +398,14 @@ class DepotDownloader @JvmOverloads constructor(
filesystem.createDirectories(fileStagingPath.parent!!)

httpClient.getClient().use { client ->
logger?.debug("Starting download of $fileName...")
if (debug) logger?.debug("Starting download of $fileName...")

val response = client.get(url)
val channel = response.bodyAsChannel()

val totalBytes = response.headers[HttpHeaders.ContentLength]?.toLongOrNull()

logger?.debug("File size: ${totalBytes?.let { Util.formatBytes(it) } ?: "Unknown"}")
if (debug) logger?.debug("File size: ${totalBytes?.let { Util.formatBytes(it) } ?: "Unknown"}")

filesystem.sink(fileStagingPath).buffer().use { sink ->
val buffer = Buffer()
Expand All @@ -423,17 +423,17 @@ class DepotDownloader @JvmOverloads constructor(
}
}

logger?.debug("Download completed.")
if (debug) logger?.debug("Download completed.")
}

if (filesystem.exists(fileFinalPath)) {
logger?.debug("Deleting $fileFinalPath")
if (debug) logger?.debug("Deleting $fileFinalPath")
filesystem.delete(fileFinalPath)
}

try {
filesystem.atomicMove(fileStagingPath, fileFinalPath)
logger?.debug("File '$fileStagingPath' moved to final location: $fileFinalPath")
if (debug) logger?.debug("File '$fileStagingPath' moved to final location: $fileFinalPath")
} catch (e: IOException) {
logger?.error("Failed to move files", e)
throw e
Expand Down Expand Up @@ -470,7 +470,7 @@ class DepotDownloader @JvmOverloads constructor(

if (!accountHasAccess(appId, appId)) {
if (steamUser.steamID!!.accountType != EAccountType.AnonUser && steam3!!.requestFreeAppLicense(appId)) {
logger?.debug("Obtained FreeOnDemand license for app $appId")
if (debug) logger?.debug("Obtained FreeOnDemand license for app $appId")

// Fetch app info again in case we didn't get it fully without a license.
steam3!!.requestAppInfo(appId, true)
Expand All @@ -494,7 +494,7 @@ class DepotDownloader @JvmOverloads constructor(

depotIdsFound.addAll(depotIdsExpected)
} else {
logger?.debug("Using app branch: $branch")
if (debug) logger?.debug("Using app branch: $branch")

depots?.children?.forEach { depotSection ->
if (depotSection.children.isEmpty()) {
Expand Down Expand Up @@ -946,10 +946,12 @@ class DepotDownloader @JvmOverloads constructor(
}
}

logger?.debug(
"Total downloaded: ${downloadCounter.totalBytesCompressed} bytes " +
"(${downloadCounter.totalBytesUncompressed} bytes uncompressed) from ${depots.size} depots"
)
if (debug) {
logger?.debug(
"Total downloaded: ${downloadCounter.totalBytesCompressed} bytes " +
"(${downloadCounter.totalBytesUncompressed} bytes uncompressed) from ${depots.size} depots"
)
}
}

private suspend fun processDepotManifestAndFiles(
Expand All @@ -958,7 +960,7 @@ class DepotDownloader @JvmOverloads constructor(
): DepotFilesData? = withContext(Dispatchers.IO) {
val depotCounter = DepotDownloadCounter()

logger?.debug("Processing depot ${depot.depotId}")
if (debug) logger?.debug("Processing depot ${depot.depotId}")

var oldManifest: DepotManifest? = null

Expand All @@ -983,14 +985,14 @@ class DepotDownloader @JvmOverloads constructor(

if (lastManifestId == depot.manifestId && oldManifest != null) {
newManifest = oldManifest
logger?.debug("Already have manifest ${depot.manifestId} for depot ${depot.depotId}.")
if (debug) logger?.debug("Already have manifest ${depot.manifestId} for depot ${depot.depotId}.")
} else {
newManifest = Util.loadManifestFromFile(configDir, depot.depotId, depot.manifestId, true)

if (newManifest != null) {
logger?.debug("Already have manifest ${depot.manifestId} for depot ${depot.depotId}.")
if (debug) logger?.debug("Already have manifest ${depot.manifestId} for depot ${depot.depotId}.")
} else {
logger?.debug("Downloading depot ${depot.depotId} manifest")
if (debug) logger?.debug("Downloading depot ${depot.depotId} manifest")
notifyListeners { it.onStatusUpdate("Downloading manifest for depot ${depot.depotId}") }

var manifestRequestCode: ULong = 0U
Expand Down Expand Up @@ -1040,7 +1042,7 @@ class DepotDownloader @JvmOverloads constructor(
}
}

logger?.debug("Downloading manifest ${depot.manifestId} from $connection with ${cdnClientPool!!.proxyServer ?: "no proxy"}")
if (debug) logger?.debug("Downloading manifest ${depot.manifestId} from $connection with ${cdnClientPool!!.proxyServer ?: "no proxy"}")

newManifest = cdnClientPool!!.cdnClient!!.downloadManifest(
depotId = depot.depotId,
Expand Down Expand Up @@ -1100,7 +1102,7 @@ class DepotDownloader @JvmOverloads constructor(
}
}

logger?.debug("Manifest ${depot.manifestId} (${newManifest.creationTime})")
if (debug) logger?.debug("Manifest ${depot.manifestId} (${newManifest.creationTime})")

if (config.downloadManifestOnly) {
Util.dumpManifestToTextFile(depot, newManifest)
Expand Down Expand Up @@ -1162,7 +1164,7 @@ class DepotDownloader @JvmOverloads constructor(
val depot = depotFilesData.depotDownloadInfo
val depotCounter = depotFilesData.depotCounter

logger?.debug("Downloading depot ${depot.depotId}")
if (debug) logger?.debug("Downloading depot ${depot.depotId}")

val files = depotFilesData.filteredFiles.filter { !it.flags.contains(EDepotFileFlag.Directory) }

Expand All @@ -1185,14 +1187,14 @@ class DepotDownloader @JvmOverloads constructor(
}
} finally {
if (isLastDepot) {
logger?.debug("Waiting for ${pendingChunks.get()} pending chunks to complete for depot ${depot.depotId}")
if (debug) logger?.debug("Waiting for ${pendingChunks.get()} pending chunks to complete for depot ${depot.depotId}")

// Wait for all pending chunks to complete processing
while (pendingChunks.get() > 0) {
kotlinx.coroutines.delay(100)
delay(100)
}

logger?.debug("All chunks completed, canceling processing job for depot ${depot.depotId}")
if (debug) logger?.debug("All chunks completed, canceling processing job for depot ${depot.depotId}")

// Cancel the continuous flow job since no more chunks will be added
chunkProcessingJob?.cancel()
Expand Down Expand Up @@ -1225,7 +1227,7 @@ class DepotDownloader @JvmOverloads constructor(
}

filesystem.delete(fileFinalPath)
logger?.debug("Deleted $fileFinalPath")
if (debug) logger?.debug("Deleted $fileFinalPath")
}
}

Expand All @@ -1241,7 +1243,7 @@ class DepotDownloader @JvmOverloads constructor(
)
}

logger?.debug("Depot ${depot.depotId} - Downloaded ${depotCounter.depotBytesCompressed} bytes (${depotCounter.depotBytesUncompressed} bytes uncompressed)")
if (debug) logger?.debug("Depot ${depot.depotId} - Downloaded ${depotCounter.depotBytesCompressed} bytes (${depotCounter.depotBytesUncompressed} bytes uncompressed)")

if (isLastDepot) {
finishDepotDownload(mainAppId)
Expand Down Expand Up @@ -1276,7 +1278,8 @@ class DepotDownloader @JvmOverloads constructor(
var neededChunks: MutableList<ChunkData>? = null
val fileDidExist = filesystem.exists(fileFinalPath)
if (!fileDidExist) {
logger?.debug("Pre-allocating: $fileFinalPath")
if (debug) logger?.debug("Pre-allocating: $fileFinalPath")

notifyListeners { it.onStatusUpdate("Allocating file: ${file.fileName}") }

// create new file. need all chunks
Expand All @@ -1299,7 +1302,7 @@ class DepotDownloader @JvmOverloads constructor(
if (config.verifyAll || !hashMatches) {
// we have a version of this file, but it doesn't fully match what we want
if (config.verifyAll) {
logger?.debug("Validating: $fileFinalPath")
if (debug) logger?.debug("Validating: $fileFinalPath")
}

val matchingChunks = arrayListOf<ChunkMatch>()
Expand Down Expand Up @@ -1396,7 +1399,8 @@ class DepotDownloader @JvmOverloads constructor(
}

filesystem.openReadWrite(fileFinalPath).use { handle ->
logger?.debug("Validating $fileFinalPath")
if (debug) logger?.debug("Validating $fileFinalPath")

notifyListeners { it.onStatusUpdate("Validating: ${file.fileName}") }

neededChunks = Util.validateSteam3FileChecksums(
Expand All @@ -1412,7 +1416,8 @@ class DepotDownloader @JvmOverloads constructor(

val percentage =
(depotDownloadCounter.sizeDownloaded / depotDownloadCounter.completeDownloadSize.toFloat()) * 100.0f
logger?.debug("%.2f%% %s".format(percentage, fileFinalPath))

if (debug) logger?.debug("%.2f%% %s".format(percentage, fileFinalPath))
}

synchronized(downloadCounter) {
Expand Down Expand Up @@ -1503,7 +1508,7 @@ class DepotDownloader @JvmOverloads constructor(
}
}

logger?.debug("Downloading chunk $chunkID from $connection with ${cdnClientPool!!.proxyServer ?: "no proxy"}")
if (debug) logger?.debug("Downloading chunk $chunkID from $connection with ${cdnClientPool!!.proxyServer ?: "no proxy"}")

downloaded = cdnClientPool!!.cdnClient!!.downloadDepotChunk(
depotId = depot.depotId,
Expand Down Expand Up @@ -1700,13 +1705,13 @@ class DepotDownloader @JvmOverloads constructor(

when (item) {
is PubFileItem -> {
logger?.debug("Downloading PUB File for ${item.appId}")
if (debug) logger?.debug("Downloading PUB File for ${item.appId}")
notifyListeners { it.onDownloadStarted(item) }
downloadPubFile(item.appId, item.pubFile)
}

is UgcItem -> {
logger?.debug("Downloading UGC File for ${item.appId}")
if (debug) logger?.debug("Downloading UGC File for ${item.appId}")
notifyListeners { it.onDownloadStarted(item) }
downloadUGC(item.appId, item.ugcId)
}
Expand Down Expand Up @@ -1758,8 +1763,10 @@ class DepotDownloader @JvmOverloads constructor(
depotManifestIds.addAll(depotIdList.map { it to INVALID_MANIFEST_ID })
}

logger?.debug("Downloading App for ${item.appId}")
if (debug) logger?.debug("Downloading App for ${item.appId}")

notifyListeners { it.onDownloadStarted(item) }

downloadApp(
appId = item.appId,
depotManifestIds = depotManifestIds,
Expand Down Expand Up @@ -1863,7 +1870,7 @@ class DepotDownloader @JvmOverloads constructor(
)
}

logger?.debug("%.2f%% %s".format(depotPercentage, fileFinalPath))
if (debug) logger?.debug("%.2f%% %s".format(depotPercentage, fileFinalPath))
} else {
// Update counters and notify on chunk completion
val sizeDownloaded: Long
Expand Down
Loading