moby / buildkit

concurrent, cache-efficient, and Dockerfile-agnostic builder toolkit
https://github.com/moby/moby/issues/34227
Apache License 2.0
8.24k stars 1.17k forks source link

Flaky test: `TestWarningsBeforeError` #5392

Open crazy-max opened 1 month ago

crazy-max commented 1 month ago

Happened on windows integration tests: https://github.com/moby/buildkit/actions/runs/11162974334/job/31028930617?pr=5390#step:8:2175

=== FAIL: frontend/dockerfile TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client/warntype=progress (0.30s)
    dockerfile_lint_test.go:1523: 
            Error Trace:    D:/a/buildkit/buildkit/frontend/dockerfile/dockerfile_lint_test.go:1462
                                        D:/a/buildkit/buildkit/frontend/dockerfile/dockerfile_lint_test.go:1523
            Error:          Error message not equal:
                            expected: "failed to solve: dockerfile parse error on line 4: unknown instruction: BADCMD"
                            actual  : "failed to run Build function: dockerfile parse error on line 4: unknown instruction: BADCMD"
            Test:           TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client/warntype=progress
        --- FAIL: TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client/warntype=progress (0.30s)

=== FAIL: frontend/dockerfile TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client (0.74s)
    sandbox.go:135: stdout: D:\a\buildkit\buildkit\bin\containerd.exe --config C:\Users\RUNNER~1\AppData\Local\Temp\bktest_containerd3339088479\config.toml
    sandbox.go:135: stderr: D:\a\buildkit\buildkit\bin\containerd.exe --config C:\Users\RUNNER~1\AppData\Local\Temp\bktest_containerd3339088479\config.toml
    sandbox.go:138: > StartCmd 2024-10-03 13:59:14.2466889 +0000 UTC m=+1440.263738501 D:\a\buildkit\buildkit\bin\containerd.exe --config C:\Users\RUNNER~1\AppData\Local\Temp\bktest_containerd3339088479\config.toml
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=warning msg="containerd config version `1` has been deprecated and will be converted on each startup in containerd v2.0, use `containerd config migrate` after upgrading to containerd 2.0 to avoid conversion on startup"
    sandbox.go:138: time="2024-10-03T13:59:14.296866200Z" level=info msg="starting containerd" revision=472731909fa34bd7bc9c087e4c27943f9835f111 version=v1.7.21
    sandbox.go:138: time="2024-10-03T13:59:14.296866200Z" level=debug msg="Stackdump - waiting signal at Global\\stackdump-5792"
    sandbox.go:138: time="2024-10-03T13:59:14.310902000Z" level=info msg="loading plugin \"io.containerd.event.v1.exchange\"..." type=io.containerd.event.v1
    sandbox.go:138: time="2024-10-03T13:59:14.310902000Z" level=info msg="loading plugin \"io.containerd.internal.v1.opt\"..." type=io.containerd.internal.v1
    sandbox.go:138: time="2024-10-03T13:59:14.311572200Z" level=info msg="loading plugin \"io.containerd.warning.v1.deprecations\"..." type=io.containerd.warning.v1
    sandbox.go:138: time="2024-10-03T13:59:14.311572200Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.windows-lcow\"..." type=io.containerd.snapshotter.v1
    sandbox.go:138: time="2024-10-03T13:59:14.312124500Z" level=info msg="loading plugin \"io.containerd.snapshotter.v1.windows\"..." type=io.containerd.snapshotter.v1
    sandbox.go:138: time="2024-10-03T13:59:14.312676200Z" level=info msg="loading plugin \"io.containerd.content.v1.content\"..." type=io.containerd.content.v1
    sandbox.go:138: time="2024-10-03T13:59:14.313267700Z" level=info msg="loading plugin \"io.containerd.metadata.v1.bolt\"..." type=io.containerd.metadata.v1
    sandbox.go:138: time="2024-10-03T13:59:14.313267700Z" level=info msg="metadata content store policy set" policy=shared
    sandbox.go:138: time="2024-10-03T13:59:14.327662500Z" level=info msg="loading plugin \"io.containerd.gc.v1.scheduler\"..." type=io.containerd.gc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.328530300Z" level=info msg="loading plugin \"io.containerd.differ.v1.windows-lcow\"..." type=io.containerd.differ.v1
    sandbox.go:138: time="2024-10-03T13:59:14.328530300Z" level=info msg="loading plugin \"io.containerd.differ.v1.walking\"..." type=io.containerd.differ.v1
    sandbox.go:138: time="2024-10-03T13:59:14.328530300Z" level=info msg="loading plugin \"io.containerd.differ.v1.windows\"..." type=io.containerd.differ.v1
    sandbox.go:138: time="2024-10-03T13:59:14.328530300Z" level=info msg="loading plugin \"io.containerd.lease.v1.manager\"..." type=io.containerd.lease.v1
    sandbox.go:138: time="2024-10-03T13:59:14.328530300Z" level=info msg="loading plugin \"io.containerd.streaming.v1.manager\"..." type=io.containerd.streaming.v1
    sandbox.go:138: time="2024-10-03T13:59:14.328530300Z" level=info msg="loading plugin \"io.containerd.runtime.v2.task\"..." type=io.containerd.runtime.v2
    sandbox.go:138: time="2024-10-03T13:59:14.329082500Z" level=info msg="loading plugin \"io.containerd.runtime.v2.shim\"..." type=io.containerd.runtime.v2
    sandbox.go:138: time="2024-10-03T13:59:14.329082500Z" level=info msg="loading plugin \"io.containerd.sandbox.store.v1.local\"..." type=io.containerd.sandbox.store.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329082500Z" level=info msg="loading plugin \"io.containerd.sandbox.controller.v1.local\"..." type=io.containerd.sandbox.controller.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329082500Z" level=info msg="loading plugin \"io.containerd.service.v1.containers-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329082500Z" level=info msg="loading plugin \"io.containerd.service.v1.content-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329082500Z" level=info msg="loading plugin \"io.containerd.service.v1.diff-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329599000Z" level=info msg="loading plugin \"io.containerd.service.v1.images-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329599000Z" level=info msg="loading plugin \"io.containerd.service.v1.introspection-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329599000Z" level=info msg="loading plugin \"io.containerd.service.v1.namespaces-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329666100Z" level=info msg="loading plugin \"io.containerd.service.v1.snapshots-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329687100Z" level=info msg="loading plugin \"io.containerd.service.v1.tasks-service\"..." type=io.containerd.service.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329687100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.containers\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329687100Z" level=info msg="loading plugin \"io.containerd.grpc.v1.content\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329753500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.diff\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329753500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.events\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329753500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.images\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329753500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.introspection\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329753500Z" level=info msg="loading plugin \"io.containerd.grpc.v1.leases\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329820800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.namespaces\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329843800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandbox-controllers\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329843800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.sandboxes\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329843800Z" level=info msg="loading plugin \"io.containerd.grpc.v1.snapshots\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329906000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.streaming\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329906000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.tasks\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329906000Z" level=info msg="loading plugin \"io.containerd.transfer.v1.local\"..." type=io.containerd.transfer.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329967400Z" level=warning msg="multiple differs match for platform, set `differ` option to choose, skipping \"windows\""
    sandbox.go:138: time="2024-10-03T13:59:14.329967400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.transfer\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.329967400Z" level=info msg="loading plugin \"io.containerd.grpc.v1.version\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330056600Z" level=info msg="loading plugin \"io.containerd.internal.v1.restart\"..." type=io.containerd.internal.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330117900Z" level=info msg="loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." type=io.containerd.tracing.processor.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="skip loading plugin \"io.containerd.tracing.processor.v1.otlp\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.tracing.processor.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="loading plugin \"io.containerd.internal.v1.tracing\"..." type=io.containerd.internal.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="skip loading plugin \"io.containerd.internal.v1.tracing\"..." error="skip plugin: tracing endpoint not configured" type=io.containerd.internal.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="loading plugin \"io.containerd.grpc.v1.healthcheck\"..." type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="loading plugin \"io.containerd.nri.v1.nri\"..." type=io.containerd.nri.v1
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="NRI interface is disabled by configuration."
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg=serving... address="\\\\.\\pipe\\containerd-bktest_containerd3339088479debug"
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg=serving... address="\\\\.\\pipe\\containerd-bktest_containerd3339088479.ttrpc"
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg=serving... address="\\\\.\\pipe\\containerd-bktest_containerd3339088479"
    sandbox.go:138: time="2024-10-03T13:59:14.330214000Z" level=info msg="containerd successfully booted in 0.065347s"
    sandbox.go:138: time="2024-10-03T13:59:14.518137800Z" level=debug msg="prepare snapshot" key=sres1kcc1im4d3a5wtewcc48r parent=
    sandbox.go:138: time="2024-10-03T13:59:14.525118500Z" level=debug msg=createSnapshot
    sandbox.go:138: time="2024-10-03T13:59:14.573750500Z" level=debug msg="get snapshot mounts" key=sres1kcc1im4d3a5wtewcc48r
    sandbox.go:138: time="2024-10-03T13:59:14.614128400Z" level=debug msg="get snapshot mounts" key=sres1kcc1im4d3a5wtewcc48r
    sandbox.go:138: time="2024-10-03T13:59:14.629234800Z" level=debug msg="(*service).Write started" ref=history-ref_622176300-J_I5
    sandbox.go:138: time="2024-10-03T13:59:14.696906400Z" level=debug msg="(*service).Write started" ref=history-ref_680970900-cVpu
    sandbox.go:138: time="2024-10-03T13:59:14.852534900Z" level=debug msg="get snapshot mounts" key=sres1kcc1im4d3a5wtewcc48r
    sandbox.go:138: time="2024-10-03T13:59:14.869712100Z" level=debug msg="(*service).Write started" ref=history-ref_868053800-Z4VS
    sandbox.go:135: stdout: D:\a\buildkit\buildkit\bin\buildkitd.exe --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3339088479 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config3904960777\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd1136501169 --addr npipe:////./pipe/buildkitd-bktest_buildkitd1136501169 --debug
    sandbox.go:135: stderr: D:\a\buildkit\buildkit\bin\buildkitd.exe --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3339088479 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config3904960777\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd1136501169 --addr npipe:////./pipe/buildkitd-bktest_buildkitd1136501169 --debug
    sandbox.go:138: > StartCmd 2024-10-03 13:59:14.3603633 +0000 UTC m=+1440.377412101 D:\a\buildkit\buildkit\bin\buildkitd.exe --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3339088479 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config3904960777\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd1136501169 --addr npipe:////./pipe/buildkitd-bktest_buildkitd1136501169 --debug
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=warning msg="failed to get disk size: The system cannot find the path specified."
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=warning msg="using null network as the default"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="remote introspection plugin filters" filters="[type==io.containerd.runtime.v1 type==io.containerd.runtime.v2]"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=info msg="found worker \"rtcyn3il3ohxuqnbtt2qw9vpi\", labels=map[org.mobyproject.buildkit.worker.containerd.namespace:buildkit org.mobyproject.buildkit.worker.containerd.uuid:3e750e64-c7f4-4865-9545-85a78dc876a5 org.mobyproject.buildkit.worker.executor:containerd org.mobyproject.buildkit.worker.hostname:fv-az1111-261 org.mobyproject.buildkit.worker.network: org.mobyproject.buildkit.worker.sandbox:true org.mobyproject.buildkit.worker.selinux.enabled:false org.mobyproject.buildkit.worker.snapshotter:windows], platforms=[windows/amd64]"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=info msg="found 1 workers, default=\"rtcyn3il3ohxuqnbtt2qw9vpi\""
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=warning msg="currently, only the default worker can be used."
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=info msg="running server on //./pipe/buildkitd-bktest_buildkitd1136501169"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="session started" spanID=407a94c827d3bdef traceID=3e7317a194bba1d33126f89819fcd05d
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="new ref for local: sres1kcc1im4d3a5wtewcc48r" span="[internal] load build definition from Dockerfile" spanID=a78178edf586edb7 traceID=3d0f95416d80d053fd6cb46f176c360c
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="diffcopy took: 3.6929ms" span="[internal] load build definition from Dockerfile" spanID=42a71a7e89519b0c traceID=3d0f95416d80d053fd6cb46f176c360c
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="saved sres1kcc1im4d3a5wtewcc48r as dockerfile:dockerfile:" span="[internal] load build definition from Dockerfile" spanID=a78178edf586edb7 traceID=3d0f95416d80d053fd6cb46f176c360c
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-10-03T13:59:14Z" level=error msg="/moby.buildkit.v1.frontend.LLBBridge/ReadFile returned error: rpc error: code = Unknown desc = open Dockerfile.dockerignore: The system cannot find the file specified." spanID=a75c30e510baf4df traceID=66be2a9bcaa757fc835a6300738e181c
    sandbox.go:138: open Dockerfile.dockerignore: The system cannot find the file specified.
    sandbox.go:138: 4948 2321320 buildkitd --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3339088479 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config3904960777\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd1136501169 --addr npipe:////./pipe/buildkitd-bktest_buildkitd1136501169 --debug
    sandbox.go:138: github.com/moby/buildkit/cache/util.ReadFile.func1
    sandbox.go:138:     /src/cache/util/fsutil.go:68
    sandbox.go:138: github.com/moby/buildkit/cache/util.withMount
    sandbox.go:138:     /src/cache/util/fsutil.go:40
    sandbox.go:138: github.com/moby/buildkit/cache/util.ReadFile
    sandbox.go:138:     /src/cache/util/fsutil.go:54
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway.(*llbBridgeForwarder).ReadFile
    sandbox.go:138:     /src/frontend/gateway/gateway.go:935
    sandbox.go:138: github.com/moby/buildkit/control/gateway.(*GatewayForwarder).ReadFile
    sandbox.go:138:     /src/control/gateway/gateway.go:122
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway/pb._LLBBridge_ReadFile_Handler.func1
    sandbox.go:138:     /src/frontend/gateway/pb/gateway_grpc.pb.go:383
    sandbox.go:138: google.golang.org/grpc.getChainUnaryHandler.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1211
    sandbox.go:138: main.unaryInterceptor
    sandbox.go:138:     /src/cmd/buildkitd/main.go:711
    sandbox.go:138: google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1202
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway/pb._LLBBridge_ReadFile_Handler
    sandbox.go:138:     /src/frontend/gateway/pb/gateway_grpc.pb.go:385
    sandbox.go:138: google.golang.org/grpc.(*Server).processUnaryRPC
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1394
    sandbox.go:138: google.golang.org/grpc.(*Server).handleStream
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1805
    sandbox.go:138: google.golang.org/grpc.(*Server).serveStreams.func2.1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1029
    sandbox.go:138: runtime.goexit
    sandbox.go:138:     /usr/local/go/src/runtime/asm_amd64.s:1695
crazy-max commented 1 day ago

Again in https://github.com/moby/buildkit/actions/runs/11986340366/job/33419332165?pr=5548#step:8:2173

=== Failed
=== FAIL: frontend/dockerfile TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client/warntype=progress (0.27s)
    dockerfile_lint_test.go:1645: 
            Error Trace:    D:/a/buildkit/buildkit/frontend/dockerfile/dockerfile_lint_test.go:1572
                                        D:/a/buildkit/buildkit/frontend/dockerfile/dockerfile_lint_test.go:1645
            Error:          Error message not equal:
                            expected: "failed to solve: dockerfile parse error on line 4: unknown instruction: BADCMD"
                            actual  : "failed to run Build function: dockerfile parse error on line 4: unknown instruction: BADCMD"
            Test:           TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client/warntype=progress
        --- FAIL: TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client/warntype=progress (0.27s)

=== FAIL: frontend/dockerfile TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client (0.92s)
    sandbox.go:135: stdout: D:\a\buildkit\buildkit\bin\containerd.exe --config C:\Users\RUNNER~1\AppData\Local\Temp\bktest_containerd3711649010\config.toml
    sandbox.go:135: stderr: D:\a\buildkit\buildkit\bin\containerd.exe --config C:\Users\RUNNER~1\AppData\Local\Temp\bktest_containerd3711649010\config.toml
    sandbox.go:138: > StartCmd 2024-11-23 10:56:13.1434344 +0000 UTC m=+1892.376861901 D:\a\buildkit\buildkit\bin\containerd.exe --config C:\Users\RUNNER~1\AppData\Local\Temp\bktest_containerd3711649010\config.toml
    sandbox.go:138: time="2024-11-23T10:56:13.162715500Z" level=info msg="starting containerd" revision= version=2.0.0+unknown
    sandbox.go:138: time="2024-11-23T10:56:13.162715500Z" level=debug msg="Stackdump - waiting signal at Global\\stackdump-7040"
    sandbox.go:138: time="2024-11-23T10:56:13.190160400Z" level=info msg="loading plugin" id=io.containerd.internal.v1.opt type=io.containerd.internal.v1
    sandbox.go:138: time="2024-11-23T10:56:13.190160400Z" level=info msg="loading plugin" id=io.containerd.content.v1.content type=io.containerd.content.v1
    sandbox.go:138: time="2024-11-23T10:56:13.190160400Z" level=info msg="loading plugin" id=io.containerd.image-verifier.v1.bindir type=io.containerd.image-verifier.v1
    sandbox.go:138: time="2024-11-23T10:56:13.190160400Z" level=info msg="loading plugin" id=io.containerd.warning.v1.deprecations type=io.containerd.warning.v1
    sandbox.go:138: time="2024-11-23T10:56:13.190160400Z" level=info msg="loading plugin" id=io.containerd.event.v1.exchange type=io.containerd.event.v1
    sandbox.go:138: time="2024-11-23T10:56:13.190160400Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.windows-lcow type=io.containerd.snapshotter.v1
    sandbox.go:138: time="2024-11-23T10:56:13.195851300Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.cimfs type=io.containerd.snapshotter.v1
    sandbox.go:138: time="2024-11-23T10:56:13.451903100Z" level=info msg="loading plugin" id=io.containerd.snapshotter.v1.windows type=io.containerd.snapshotter.v1
    sandbox.go:138: time="2024-11-23T10:56:13.452503100Z" level=info msg="loading plugin" id=io.containerd.metadata.v1.bolt type=io.containerd.metadata.v1
    sandbox.go:138: time="2024-11-23T10:56:13.452503100Z" level=info msg="metadata content store policy set" policy=shared
    sandbox.go:138: time="2024-11-23T10:56:13.467748300Z" level=info msg="loading plugin" id=io.containerd.gc.v1.scheduler type=io.containerd.gc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.467748300Z" level=info msg="loading plugin" id=io.containerd.differ.v1.windows-lcow type=io.containerd.differ.v1
    sandbox.go:138: time="2024-11-23T10:56:13.467748300Z" level=info msg="loading plugin" id=io.containerd.differ.v1.cimfs type=io.containerd.differ.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468343000Z" level=info msg="loading plugin" id=io.containerd.differ.v1.windows type=io.containerd.differ.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468391900Z" level=info msg="loading plugin" id=io.containerd.lease.v1.manager type=io.containerd.lease.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468439700Z" level=info msg="loading plugin" id=io.containerd.streaming.v1.manager type=io.containerd.streaming.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468487300Z" level=info msg="loading plugin" id=io.containerd.transfer.v1.local type=io.containerd.transfer.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468581600Z" level=info msg="loading plugin" id=io.containerd.service.v1.containers-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468639000Z" level=info msg="loading plugin" id=io.containerd.service.v1.content-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468663100Z" level=info msg="loading plugin" id=io.containerd.service.v1.diff-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468732700Z" level=info msg="loading plugin" id=io.containerd.service.v1.images-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468778900Z" level=info msg="loading plugin" id=io.containerd.service.v1.introspection-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468803800Z" level=info msg="loading plugin" id=io.containerd.service.v1.namespaces-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468850900Z" level=info msg="loading plugin" id=io.containerd.service.v1.snapshots-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468898100Z" level=info msg="loading plugin" id=io.containerd.shim.v1.manager type=io.containerd.shim.v1
    sandbox.go:138: time="2024-11-23T10:56:13.468951400Z" level=info msg="loading plugin" id=io.containerd.runtime.v2.task type=io.containerd.runtime.v2
    sandbox.go:138: time="2024-11-23T10:56:13.469644500Z" level=info msg="loading plugin" id=io.containerd.service.v1.tasks-service type=io.containerd.service.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469726400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.containers type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469778200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.content type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469824900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.diff type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469871400Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.events type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469918200Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.images type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469963700Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.introspection type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.469987600Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.leases type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.470033800Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.namespaces type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.470056300Z" level=info msg="loading plugin" id=io.containerd.sandbox.store.v1.local type=io.containerd.sandbox.store.v1
    sandbox.go:138: time="2024-11-23T10:56:13.470106000Z" level=info msg="loading plugin" id=io.containerd.cri.v1.images type=io.containerd.cri.v1
    sandbox.go:138: time="2024-11-23T10:56:13.470106000Z" level=info msg="Get image filesystem path \"C:\\\\Users\\\\RUNNER~1\\\\AppData\\\\Local\\\\Temp\\\\bktest_containerd3711649010\\\\root\\\\io.containerd.snapshotter.v1.windows\" for snapshotter \"windows\""
    sandbox.go:138: time="2024-11-23T10:56:13.470106000Z" level=info msg="Start snapshots syncer"
    sandbox.go:138: time="2024-11-23T10:56:13.470106000Z" level=info msg="loading plugin" id=io.containerd.cri.v1.runtime type=io.containerd.cri.v1
    sandbox.go:138: time="2024-11-23T10:56:13.470718400Z" level=info msg="starting cri plugin" config="{\"containerd\":{\"defaultRuntimeName\":\"runhcs-wcow-process\",\"runtimes\":{\"runhcs-wcow-hypervisor\":{\"runtimeType\":\"io.containerd.runhcs.v1\",\"runtimePath\":\"\",\"PodAnnotations\":[\"io.microsoft.virtualmachine.*\"],\"ContainerAnnotations\":[\"io.microsoft.container.*\"],\"options\":{\"SandboxIsolation\":1,\"ScaleCpuLimitsToSandbox\":true},\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"},\"runhcs-wcow-process\":{\"runtimeType\":\"io.containerd.runhcs.v1\",\"runtimePath\":\"\",\"PodAnnotations\":null,\"ContainerAnnotations\":[\"io.microsoft.container.*\"],\"options\":null,\"privileged_without_host_devices\":false,\"privileged_without_host_devices_all_devices_allowed\":false,\"baseRuntimeSpec\":\"\",\"cniConfDir\":\"\",\"cniMaxConfNum\":0,\"snapshotter\":\"\",\"sandboxer\":\"podsandbox\",\"io_type\":\"\"}},\"ignoreBlockIONotEnabledErrors\":false,\"ignoreRdtNotEnabledErrors\":false},\"cni\":{\"binDir\":\"C:\\\\Program Files\\\\containerd\\\\cni\\\\bin\",\"confDir\":\"C:\\\\Program Files\\\\containerd\\\\cni\\\\conf\",\"maxConfNum\":1,\"setupSerially\":false,\"confTemplate\":\"\",\"ipPref\":\"\",\"useInternalLoopback\":false},\"enableSelinux\":false,\"selinuxCategoryRange\":0,\"maxContainerLogSize\":16384,\"disableApparmor\":false,\"restrictOOMScoreAdj\":false,\"disableProcMount\":false,\"unsetSeccompProfile\":\"\",\"tolerateMissingHugetlbController\":false,\"disableHugetlbController\":false,\"device_ownership_from_security_context\":false,\"ignoreImageDefinedVolumes\":false,\"netnsMountsUnderStateDir\":false,\"enableUnprivilegedPorts\":false,\"enableUnprivilegedICMP\":false,\"enableCDI\":false,\"cdiSpecDirs\":null,\"drainExecSyncIOTimeout\":\"0s\",\"ignoreDeprecationWarnings\":null,\"containerdRootDir\":\"C:\\\\Users\\\\RUNNER~1\\\\AppData\\\\Local\\\\Temp\\\\bktest_containerd3711649010\\\\root\",\"containerdEndpoint\":\"\\\\\\\\.\\\\pipe\\\\containerd-bktest_containerd3711649010\",\"rootDir\":\"C:\\\\Users\\\\RUNNER~1\\\\AppData\\\\Local\\\\Temp\\\\bktest_containerd3711649010\\\\root\\\\io.containerd.grpc.v1.cri\",\"stateDir\":\"C:\\\\Users\\\\RUNNER~1\\\\AppData\\\\Local\\\\Temp\\\\bktest_containerd3711649010\\\\state\\\\io.containerd.grpc.v1.cri\"}"
    sandbox.go:138: time="2024-11-23T10:56:13.470718400Z" level=info msg="loading plugin" id=io.containerd.podsandbox.controller.v1.podsandbox type=io.containerd.podsandbox.controller.v1
    sandbox.go:138: time="2024-11-23T10:56:13.471140400Z" level=info msg="loading plugin" id=io.containerd.sandbox.controller.v1.shim type=io.containerd.sandbox.controller.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472734500Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandbox-controllers type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.sandboxes type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.snapshots type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.streaming type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.tasks type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.transfer type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.version type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.monitor.container.v1.restart type=io.containerd.monitor.container.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.tracing.processor.v1.otlp type=io.containerd.tracing.processor.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="skip loading plugin" error="skip plugin: tracing endpoint not configured" id=io.containerd.internal.v1.tracing type=io.containerd.internal.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.ttrpc.v1.otelttrpc type=io.containerd.ttrpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.grpc.v1.healthcheck type=io.containerd.grpc.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="loading plugin" id=io.containerd.nri.v1.nri type=io.containerd.nri.v1
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="runtime interface created"
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg="created NRI interface"
    sandbox.go:138: time="2024-11-23T10:56:13.472759900Z" level=info msg=serving... address="\\\\.\\pipe\\containerd-bktest_containerd3711649010debug"
    sandbox.go:138: time="2024-11-23T10:56:13.473292100Z" level=info msg=serving... address="\\\\.\\pipe\\containerd-bktest_containerd3711649010.ttrpc"
    sandbox.go:138: time="2024-11-23T10:56:13.473358200Z" level=info msg=serving... address="\\\\.\\pipe\\containerd-bktest_containerd3711649010"
    sandbox.go:138: time="2024-11-23T10:56:13.473358200Z" level=info msg="containerd successfully booted in 0.310642s"
    sandbox.go:138: time="2024-11-23T10:56:13.630780600Z" level=debug msg="prepare snapshot" key=q5yhf1rfnjirky4b46ik3ru6v parent= snapshotter=windows
    sandbox.go:138: time="2024-11-23T10:56:13.640862300Z" level=debug msg=createSnapshot
    sandbox.go:138: time="2024-11-23T10:56:13.698604200Z" level=debug msg="get snapshot mounts" key=q5yhf1rfnjirky4b46ik3ru6v snapshotter=windows
    sandbox.go:138: time="2024-11-23T10:56:13.743337500Z" level=debug msg="get snapshot mounts" key=q5yhf1rfnjirky4b46ik3ru6v snapshotter=windows
    sandbox.go:138: time="2024-11-23T10:56:13.758655000Z" level=debug msg="(*service).Write started" ref=history-ref_751200000-a-bc
    sandbox.go:138: time="2024-11-23T10:56:13.807738700Z" level=debug msg="(*service).Write started" ref=history-ref_799560900-V-pU
    sandbox.go:138: time="2024-11-23T10:56:13.936977100Z" level=debug msg="get snapshot mounts" key=q5yhf1rfnjirky4b46ik3ru6v snapshotter=windows
    sandbox.go:138: time="2024-11-23T10:56:13.956895300Z" level=debug msg="(*service).Write started" ref=history-ref_951340300-YXoI
    sandbox.go:135: stdout: D:\a\buildkit\buildkit\bin\buildkitd.exe --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:135: stderr: D:\a\buildkit\buildkit\bin\buildkitd.exe --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:138: > StartCmd 2024-11-23 10:56:13.5026972 +0000 UTC m=+1892.736124201 D:\a\buildkit\buildkit\bin\buildkitd.exe --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=warning msg="using null network as the default"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="remote introspection plugin filters" filters="[type==io.containerd.runtime.v1 type==io.containerd.runtime.v2]"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=info msg="found worker \"rkg1c9cd726s0h87clcofmm58\", labels=map[org.mobyproject.buildkit.worker.containerd.namespace:buildkit org.mobyproject.buildkit.worker.containerd.uuid:26be8db0-2dd1-4919-9149-75c30efffcdd org.mobyproject.buildkit.worker.executor:containerd org.mobyproject.buildkit.worker.hostname:fv-az1115-97 org.mobyproject.buildkit.worker.network: org.mobyproject.buildkit.worker.sandbox:true org.mobyproject.buildkit.worker.selinux.enabled:false org.mobyproject.buildkit.worker.snapshotter:windows], platforms=[windows/amd64]"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=info msg="found 1 workers, default=\"rkg1c9cd726s0h87clcofmm58\""
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=warning msg="currently, only the default worker can be used."
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=info msg="running server on //./pipe/buildkitd-bktest_buildkitd3394561495"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="session started" spanID=f19391b68943bcba traceID=3c37f3c32d9c708772a05d6d8e6aca2f
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="new ref for local: q5yhf1rfnjirky4b46ik3ru6v" span="[internal] load build definition from Dockerfile" spanID=959b80414233aec0 traceID=2efde55e7b7061366059f684e3da9f75
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="diffcopy took: 3.229ms" span="[internal] load build definition from Dockerfile" spanID=3302d5e73e57cecc traceID=2efde55e7b7061366059f684e3da9f75
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="saved q5yhf1rfnjirky4b46ik3ru6v as dockerfile:dockerfile:" span="[internal] load build definition from Dockerfile" spanID=959b80414233aec0 traceID=2efde55e7b7061366059f684e3da9f75
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=error msg="/moby.buildkit.v1.frontend.LLBBridge/ReadFile returned error: rpc error: code = Unknown desc = open Dockerfile.dockerignore: The system cannot find the file specified." spanID=dd80caf2f36720d9 traceID=290c243aad2f3ae67497e8baff2ddd2b
    sandbox.go:138: open Dockerfile.dockerignore: The system cannot find the file specified.
    sandbox.go:138: 4720 ce48d28 buildkitd --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:138: github.com/moby/buildkit/cache/util.ReadFile.func1
    sandbox.go:138:     /src/cache/util/fsutil.go:68
    sandbox.go:138: github.com/moby/buildkit/cache/util.withMount
    sandbox.go:138:     /src/cache/util/fsutil.go:40
    sandbox.go:138: github.com/moby/buildkit/cache/util.ReadFile
    sandbox.go:138:     /src/cache/util/fsutil.go:54
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway.(*llbBridgeForwarder).ReadFile
    sandbox.go:138:     /src/frontend/gateway/gateway.go:934
    sandbox.go:138: github.com/moby/buildkit/control/gateway.(*GatewayForwarder).ReadFile
    sandbox.go:138:     /src/control/gateway/gateway.go:122
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway/pb._LLBBridge_ReadFile_Handler.func1
    sandbox.go:138:     /src/frontend/gateway/pb/gateway_grpc.pb.go:383
    sandbox.go:138: google.golang.org/grpc.getChainUnaryHandler.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1211
    sandbox.go:138: main.unaryInterceptor
    sandbox.go:138:     /src/cmd/buildkitd/main.go:713
    sandbox.go:138: google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1202
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway/pb._LLBBridge_ReadFile_Handler
    sandbox.go:138:     /src/frontend/gateway/pb/gateway_grpc.pb.go:385
    sandbox.go:138: google.golang.org/grpc.(*Server).processUnaryRPC
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1394
    sandbox.go:138: google.golang.org/grpc.(*Server).handleStream
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1805
    sandbox.go:138: google.golang.org/grpc.(*Server).serveStreams.func2.1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1029
    sandbox.go:138: runtime.goexit
    sandbox.go:138:     /usr/local/go/src/runtime/asm_amd64.s:1700
    sandbox.go:138: 
    sandbox.go:138: 4720 ce48d28 buildkitd --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:138: main.unaryInterceptor
    sandbox.go:138:     /src/cmd/buildkitd/main.go:717
    sandbox.go:138: google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1202
    sandbox.go:138: 
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=error msg="/moby.buildkit.v1.Control/Solve returned error: rpc error: code = Unknown desc = dockerfile parse error on line 4: unknown instruction: BADCMD" spanID=28f39ad7498dcb71 traceID=7b2ed619cc500a5f7e6fe82c20d1a7c3
    sandbox.go:138: dockerfile parse error on line 4: unknown instruction: BADCMD
    sandbox.go:138: 4304  C:\Users\RUNNER~1\AppData\Local\Temp\go-build1027999813\b001\dockerfile.test.exe -test.paniconexit0 -test.gocoverdir=C:\Users\RUNNER~1\AppData\Local\Temp\go-build1027999813\b001\gocoverdir -test.v=test2json -test.coverprofile=C:\Users\RUNNER~1\AppData\Local\Temp\go-build1027999813\b001\_cover_.out -test.v=true -test.timeout=1h0m0s -test.run=TestIntegration/.*/worker=containerd
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/parser.setLocation
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/parser/errors.go:57
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/parser.WithLocation
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/parser/errors.go:37
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/instructions.ParseInstructionWithLinter.func1
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/instructions/parse.go:77
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/instructions.ParseInstructionWithLinter
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/instructions/parse.go:145
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/instructions.Parse
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/instructions/parse.go:187
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/dockerfile2llb.toDispatchState
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/dockerfile2llb/convert.go:251
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/dockerfile2llb.Dockerfile2LLB
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/dockerfile2llb/convert.go:91
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerfile/builder.Build.func6
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerfile/builder/build.go:136
    sandbox.go:138: github.com/moby/buildkit/frontend/dockerui.(*Client).Build.func1
    sandbox.go:138:     D:/a/buildkit/buildkit/frontend/dockerui/build.go:39
    sandbox.go:138: golang.org/x/sync/errgroup.(*Group).Go.func1
    sandbox.go:138:     D:/a/buildkit/buildkit/vendor/golang.org/x/sync/errgroup/errgroup.go:78
    sandbox.go:138: runtime.goexit
    sandbox.go:138:     C:/hostedtoolcache/windows/go/1.23.3/x64/src/runtime/asm_amd64.s:1700
    sandbox.go:138: 
    sandbox.go:138: 4720 ce48d28 buildkitd --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway.(*llbBridgeForwarder).Return
    sandbox.go:138:     /src/frontend/gateway/gateway.go:1021
    sandbox.go:138: github.com/moby/buildkit/control/gateway.(*GatewayForwarder).Return
    sandbox.go:138:     /src/control/gateway/gateway.go:146
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway/pb._LLBBridge_Return_Handler.func1
    sandbox.go:138:     /src/frontend/gateway/pb/gateway_grpc.pb.go:473
    sandbox.go:138: google.golang.org/grpc.getChainUnaryHandler.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1211
    sandbox.go:138: main.unaryInterceptor
    sandbox.go:138:     /src/cmd/buildkitd/main.go:713
    sandbox.go:138: google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1202
    sandbox.go:138: github.com/moby/buildkit/frontend/gateway/pb._LLBBridge_Return_Handler
    sandbox.go:138:     /src/frontend/gateway/pb/gateway_grpc.pb.go:475
    sandbox.go:138: google.golang.org/grpc.(*Server).processUnaryRPC
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1394
    sandbox.go:138: google.golang.org/grpc.(*Server).handleStream
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1805
    sandbox.go:138: google.golang.org/grpc.(*Server).serveStreams.func2.1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1029
    sandbox.go:138: runtime.goexit
    sandbox.go:138:     /usr/local/go/src/runtime/asm_amd64.s:1700
    sandbox.go:138: 
    sandbox.go:138: 4720 ce48d28 buildkitd --containerd-worker-gc=false --containerd-worker=true --containerd-worker-addr npipe:////./pipe/containerd-bktest_containerd3711649010 --containerd-worker-labels=org.mobyproject.buildkit.worker.sandbox=true --config=C:\Users\RUNNER~1\AppData\Local\Temp\bktest_config2354871020\buildkitd.toml --root C:\Users\RUNNER~1\AppData\Local\Temp\bktest_buildkitd3394561495 --addr npipe:////./pipe/buildkitd-bktest_buildkitd3394561495 --debug
    sandbox.go:138: main.unaryInterceptor
    sandbox.go:138:     /src/cmd/buildkitd/main.go:717
    sandbox.go:138: google.golang.org/grpc.NewServer.chainUnaryServerInterceptors.chainUnaryInterceptors.func1
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1202
    sandbox.go:138: github.com/moby/buildkit/api/services/control._Control_Solve_Handler
    sandbox.go:138:     /src/api/services/control/control_grpc.pb.go:289
    sandbox.go:138: google.golang.org/grpc.(*Server).processUnaryRPC
    sandbox.go:138:     /src/vendor/google.golang.org/grpc/server.go:1394
    sandbox.go:138: 
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="session finished: <nil>" spanID=f19391b68943bcba traceID=3c37f3c32d9c708772a05d6d8e6aca2f
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="session started" spanID=208a6c4807435f92 traceID=3769f6a249947bfdad6490d626287451
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="reusing ref for local: q5yhf1rfnjirky4b46ik3ru6v" span="[internal] load build definition from Dockerfile" spanID=90a79749d9a2f5e7 traceID=810b42ac03859946724d0653d7403e34
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="diffcopy took: 5.0709ms" span="[internal] load build definition from Dockerfile" spanID=02fd10c79f33ee79 traceID=810b42ac03859946724d0653d7403e34
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (1)"
    sandbox.go:138: time="2024-11-23T10:56:13Z" level=debug msg="Calling proc (2)"
    sandbox.go:138: time="2024-11-23T10:56:14Z" level=debug msg="session finished: <nil>" spanID=208a6c4807435f92 traceID=3769f6a249947bfdad6490d626287451
    --- FAIL: TestIntegration/TestWarningsBeforeError/worker=containerd/frontend=client (0.92s)