Add more debug logs

local/php/composer.go

@@ -84,10 +84,10 @@ func Composer(dir string, args, env []string, stdout, stderr, logger io.Writer,
 				error: errors.Wrap(err, "unable to find composer, get it at https://getcomposer.org/download/"),
 			}
 		}
+		fmt.Fprintf(logger, "  (running %s %s)\n\n", path, strings.TrimSpace(strings.Join(args, " ")))
 	}
 
 	e.Args = append([]string{"php", path}, args...)
-	fmt.Fprintf(logger, "  (running %s %s)\n\n", path, strings.TrimSpace(strings.Join(args, " ")))
 	ret := e.Execute(false)
 	if ret != 0 {
 		return ComposerResult{
@@ -135,19 +135,21 @@ func composerVersion() int {
 	return DefaultComposerVersion
 }
 
-func findComposer(extraBin string) (string, error) {
+func findComposer(extraBin string, logger zerolog.Logger) (string, error) {
 	// Special support for OS specific things. They need to run before the
 	// PATH detection because most of them adds shell wrappers that we
 	// can't run via PHP.
 	if pharPath := findComposerSystemSpecific(); pharPath != "" {
 		return pharPath, nil
 	}
 	for _, file := range []string{extraBin, "composer", "composer.phar"} {
+		logger.Debug().Str("source", "Composer").Msgf(`Looking for Composer in the PATH as "%s"`, file)
 		if pharPath, _ := LookPath(file); pharPath != "" {
 			// On Windows, we don't want the .bat, but the real composer phar/PHP file
 			if strings.HasSuffix(pharPath, ".bat") {
 				pharPath = pharPath[:len(pharPath)-4] + ".phar"
 			}
+			logger.Debug().Str("source", "Composer").Msgf(`Found Composer as "%s"`, pharPath)
 			return pharPath, nil
 		}
 	}

local/php/executor.go

@@ -289,19 +289,21 @@ func (e *Executor) findComposer(extraBin string) (string, error) {
 	if scriptDir, err := e.DetectScriptDir(); err == nil {
 		for _, file := range []string{extraBin, "composer.phar", "composer"} {
 			path := filepath.Join(scriptDir, file)
+			e.Logger.Debug().Str("source", "Composer").Msgf(`Looking for Composer under "%s"`, path)
 			d, err := os.Stat(path)
 			if err != nil {
 				continue
 			}
 			if m := d.Mode(); !m.IsDir() {
 				// Yep!
+				e.Logger.Debug().Str("source", "Composer").Msgf(`Found Composer as "%s"`, path)
 				return path, nil
 			}
 		}
 	}
 
 	// fallback to default composer detection
-	return findComposer(extraBin)
+	return findComposer(extraBin, e.Logger)
 }
 
 // Execute executes the right version of PHP depending on the configuration

main.go

@@ -23,11 +23,9 @@ package main
 
 import (
 	"fmt"
-	"io"
 	"os"
 	"time"
 
-	"github.com/rs/zerolog"
 	"github.com/symfony-cli/console"
 	"github.com/symfony-cli/symfony-cli/commands"
 	"github.com/symfony-cli/symfony-cli/local/php"
@@ -52,6 +50,10 @@ func getCliExtraEnv() []string {
 }
 
 func main() {
+	if os.Getenv("SC_DEBUG") == "1" {
+		terminal.SetLogLevel(5)
+	}
+
 	args := os.Args
 	name := console.CurrentBinaryName()
 	// called via "php"?
@@ -84,7 +86,7 @@ func main() {
 	}
 	// called via "symfony composer"?
 	if len(args) >= 2 && args[1] == "composer" {
-		res := php.Composer("", args[2:], getCliExtraEnv(), os.Stdout, os.Stderr, io.Discard, zerolog.Nop())
+		res := php.Composer("", args[2:], getCliExtraEnv(), os.Stdout, os.Stderr, os.Stderr, terminal.Logger)
 		terminal.Eprintln(res.Error())
 		os.Exit(res.ExitCode())
 	}