deploy with perf logging

Author: zshannon

server/server.go

@@ -133,15 +133,19 @@ func newS3FS(version string) *s3FS {
 
 // getFromCache retrieves an entry from cache or fetches from S3
 func getFromCache(ctx context.Context, version, path string) *CacheEntry {
+	start := time.Now()
+	defer func() {
+		if duration := time.Since(start); duration > 10*time.Millisecond {
+			log.Printf("[PERF] getFromCache slow: %v for path=%s", duration, path)
+		}
+	}()
+	
 	// Normalize version - ensure it ends with exactly one slash
 	if !strings.HasSuffix(version, "/") {
 		version = version + "/"
 	}
 	cacheKey := fmt.Sprintf("%s%s", version, strings.TrimPrefix(path, "/"))
 
-	// Log S3 access for debugging
-	// log.Printf("[getFromCache] S3 lookup: bucket=%s, key=%s, version=%s, path=%s", s3Bucket, cacheKey, version, path)
-	
 	// Check cache first
 	cacheMutex.RLock()
 	if cached, ok := cache.Get(cacheKey); ok {
@@ -173,6 +177,9 @@ func getFromCache(ctx context.Context, version, path string) *CacheEntry {
 		Key:    aws.String(cacheKey),
 	})
 	s3FetchDuration.Observe(time.Since(s3FetchStart).Seconds())
+	if duration := time.Since(s3FetchStart); duration > 10*time.Millisecond {
+		log.Printf("[PERF] S3 GetObject: %v for key=%s", duration, cacheKey)
+	}
 
 	if err == nil {
 		defer result.Body.Close()
@@ -212,6 +219,9 @@ func getFromCache(ctx context.Context, version, path string) *CacheEntry {
 		Delimiter: aws.String("/"),
 	})
 	s3ListDuration.Observe(time.Since(s3ListStart).Seconds())
+	if duration := time.Since(s3ListStart); duration > 10*time.Millisecond {
+		log.Printf("[PERF] S3 ListObjectsV2: %v for prefix=%s", duration, prefix)
+	}
 
 	if err != nil {
 		s3ListErrors.Inc()
@@ -692,7 +702,9 @@ func typecheckTypeScript(code string, version string) TypecheckResponse {
 	// Track typecheck duration
 	typecheckStart := time.Now()
 	defer func() {
-		typecheckDuration.Observe(time.Since(typecheckStart).Seconds())
+		duration := time.Since(typecheckStart)
+		typecheckDuration.Observe(duration.Seconds())
+		log.Printf("[PERF] typecheckTypeScript total: %v", duration)
 	}()
 
 	// Create S3-backed filesystem for this version
@@ -783,7 +795,9 @@ func buildTypeScript(code string, version string) BuildResponse {
 	// Track compile duration
 	compileStart := time.Now()
 	defer func() {
-		compileDuration.Observe(time.Since(compileStart).Seconds())
+		duration := time.Since(compileStart)
+		compileDuration.Observe(duration.Seconds())
+		log.Printf("[PERF] buildTypeScript total: %v", duration)
 	}()
 
 	// Create S3-backed filesystem for this version