I1224 17:26:53.824125 29100 x:0] *************************** I1224 17:26:53.824152 29100 x:0] Args: [/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/image -root /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root -watchdog-action=panic -network=none -debug -alsologtostderr -platform=kvm -file-access=exclusive -overlay -network=sandbox run -bundle /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/bundle ci-gvisor-kvm-proxy-overlay-sandbox-test-1] I1224 17:26:53.824178 29100 x:0] Version release-20191213.0-48-ge013c48c78c9 I1224 17:26:53.824195 29100 x:0] PID: 29100 I1224 17:26:53.824202 29100 x:0] UID: 0, GID: 0 I1224 17:26:53.824206 29100 x:0] Configuration: I1224 17:26:53.824210 29100 x:0] RootDir: /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root I1224 17:26:53.824214 29100 x:0] Platform: kvm I1224 17:26:53.824218 29100 x:0] FileAccess: exclusive, overlay: true I1224 17:26:53.824240 29100 x:0] Network: sandbox, logging: false I1224 17:26:53.824254 29100 x:0] Strace: false, max size: 1024, syscalls: [] I1224 17:26:53.824259 29100 x:0] *************************** D1224 17:26:53.829587 29100 x:0] Spec: &{Version: Process:0xc000299110 Root:0xc00029ebc0 Hostname: Mounts:[] Hooks: Annotations:map[] Linux: Solaris: Windows:} D1224 17:26:53.829647 29100 x:0] Spec.Hooks: D1224 17:26:53.829652 29100 x:0] Spec.Linux: D1224 17:26:53.829656 29100 x:0] Spec.Process: &{Terminal:false ConsoleSize: User:{UID:0 GID:0 AdditionalGids:[] Username:} Args:[/init] Env:[SYZ_GVISOR_PROXY=1] Cwd:/tmp Capabilities:0xc000120300 Rlimits:[] NoNewPrivileges:false ApparmorProfile: OOMScoreAdj: SelinuxLabel:} D1224 17:26:53.829686 29100 x:0] Spec.Root: &{Path:/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/image Readonly:true} D1224 17:26:53.829693 29100 x:0] Spec.Mounts: [] D1224 17:26:53.829706 29100 x:0] Run container "ci-gvisor-kvm-proxy-overlay-sandbox-test-1" in root dir: /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root D1224 17:26:53.829715 29100 x:0] Create container "ci-gvisor-kvm-proxy-overlay-sandbox-test-1" in root dir: /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root D1224 17:26:53.829883 29100 x:0] Creating new sandbox for container "ci-gvisor-kvm-proxy-overlay-sandbox-test-1" D1224 17:26:53.829982 29100 x:0] Starting gofer: /proc/self/exe [--root=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root --debug=true --log= --log-format=text --debug-log= --debug-log-format=text --file-access=exclusive --overlay=true --fsgofer-host-uds=false --network=sandbox --log-packets=false --platform=kvm --strace=false --strace-syscalls= --strace-log-size=1024 --watchdog-action=Panic --panic-signal=-1 --profile=false --net-raw=false --num-network-channels=1 --rootless=false --alsologtostderr=true --ref-leak-mode=disabled --gso=true --software-gso=true --overlayfs-stale-read=false gofer --bundle /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/bundle --panic-on-write=true --spec-fd=3 --mounts-fd=4 --io-fds=5] I1224 17:26:53.872454 29100 x:0] Gofer started, PID: 32352 I1224 17:26:53.872573 29100 x:0] Creating sandbox process with addr: runsc-sandbox.ci-gvisor-kvm-proxy-overlay-sandbox-test-1 I1224 17:26:53.872655 29100 x:0] Sandbox will be started in new mount, IPC and UTS namespaces I1224 17:26:53.872662 29100 x:0] Sandbox will be started in a new PID namespace I1224 17:26:53.872672 29100 x:0] Sandbox will be started in new network namespace I1224 17:26:53.873444 29100 x:0] Sandbox will be started in new user namespace D1224 17:26:53.873466 29100 x:0] Donating FD 3: "control_server_socket" D1224 17:26:53.873480 29100 x:0] Donating FD 4: "|0" D1224 17:26:53.873487 29100 x:0] Donating FD 5: "/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/bundle/config.json" D1224 17:26:53.873498 29100 x:0] Donating FD 6: "|1" D1224 17:26:53.873503 29100 x:0] Donating FD 7: "sandbox IO FD" D1224 17:26:53.873508 29100 x:0] Donating FD 8: "/dev/kvm" D1224 17:26:53.873522 29100 x:0] Donating FD 9: "/dev/stdin" D1224 17:26:53.873527 29100 x:0] Donating FD 10: "/dev/stdout" D1224 17:26:53.873532 29100 x:0] Donating FD 11: "/dev/stderr" D1224 17:26:53.873537 29100 x:0] Starting sandbox: /proc/self/exe [runsc-sandbox --root=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root --debug=true --log= --log-format=text --debug-log= --debug-log-format=text --file-access=exclusive --overlay=true --fsgofer-host-uds=false --network=sandbox --log-packets=false --platform=kvm --strace=false --strace-syscalls= --strace-log-size=1024 --watchdog-action=Panic --panic-signal=-1 --profile=false --net-raw=false --num-network-channels=1 --rootless=false --alsologtostderr=true --ref-leak-mode=disabled --gso=true --software-gso=true --overlayfs-stale-read=false --panic-signal=15 boot --bundle=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/bundle --controller-fd=3 --mounts-fd=4 --spec-fd=5 --start-sync-fd=6 --io-fds=7 --device-fd=8 --stdio-fds=9 --stdio-fds=10 --stdio-fds=11 --pidns=true --setup-root ci-gvisor-kvm-proxy-overlay-sandbox-test-1] D1224 17:26:53.873584 29100 x:0] SysProcAttr: &{Chroot: Credential:0xc0002a2a50 Ptrace:false Setsid:true Setpgid:false Setctty:false Noctty:false Ctty:0 Foreground:false Pgid:0 Pdeathsig:killed Cloneflags:0 Unshareflags:0 UidMappings:[{ContainerID:0 HostID:65533 Size:1} {ContainerID:65534 HostID:65534 Size:1}] GidMappings:[{ContainerID:65534 HostID:65534 Size:1}] GidMappingsEnableSetgroups:false AmbientCaps:[]} I1224 17:26:53.889104 29100 x:0] Sandbox started, PID: 33092 I1224 17:26:53.920539 1 x:0] *************************** I1224 17:26:53.920564 1 x:0] Args: [runsc-sandbox --root=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root --debug=true --log= --log-format=text --debug-log= --debug-log-format=text --file-access=exclusive --overlay=true --fsgofer-host-uds=false --network=sandbox --log-packets=false --platform=kvm --strace=false --strace-syscalls= --strace-log-size=1024 --watchdog-action=Panic --panic-signal=-1 --profile=false --net-raw=false --num-network-channels=1 --rootless=false --alsologtostderr=true --ref-leak-mode=disabled --gso=true --software-gso=true --overlayfs-stale-read=false --panic-signal=15 boot --bundle=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/bundle --controller-fd=3 --mounts-fd=4 --spec-fd=5 --start-sync-fd=6 --io-fds=7 --device-fd=8 --stdio-fds=9 --stdio-fds=10 --stdio-fds=11 --pidns=true --setup-root ci-gvisor-kvm-proxy-overlay-sandbox-test-1] I1224 17:26:53.920598 1 x:0] Version release-20191213.0-48-ge013c48c78c9 I1224 17:26:53.920603 1 x:0] PID: 1 I1224 17:26:53.920609 1 x:0] UID: 0, GID: 65534 I1224 17:26:53.920618 1 x:0] Configuration: I1224 17:26:53.920621 1 x:0] RootDir: /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root I1224 17:26:53.920624 1 x:0] Platform: kvm I1224 17:26:53.920628 1 x:0] FileAccess: exclusive, overlay: true I1224 17:26:53.920651 1 x:0] Network: sandbox, logging: false I1224 17:26:53.920657 1 x:0] Strace: false, max size: 1024, syscalls: [] I1224 17:26:53.920662 1 x:0] *************************** I1224 17:26:53.921122 1 x:0] Setting up sandbox chroot in "/tmp" I1224 17:26:54.027709 1 x:0] Mounting "proc" at "/tmp/proc" I1224 17:26:54.270709 1 x:0] Execve "/proc/self/exe" again, bye! I1224 17:26:54.312560 1 x:0] *************************** I1224 17:26:54.312607 1 x:0] Args: [runsc-sandbox --root=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root --debug=true --log= --log-format=text --debug-log= --debug-log-format=text --file-access=exclusive --overlay=true --fsgofer-host-uds=false --network=sandbox --log-packets=false --platform=kvm --strace=false --strace-syscalls= --strace-log-size=1024 --watchdog-action=Panic --panic-signal=-1 --profile=false --net-raw=false --num-network-channels=1 --rootless=false --alsologtostderr=true --ref-leak-mode=disabled --gso=true --software-gso=true --overlayfs-stale-read=false --panic-signal=15 boot --bundle=/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/bundle --controller-fd=3 --mounts-fd=4 --spec-fd=5 --start-sync-fd=6 --io-fds=7 --device-fd=8 --stdio-fds=9 --stdio-fds=10 --stdio-fds=11 --pidns=true ci-gvisor-kvm-proxy-overlay-sandbox-test-1] I1224 17:26:54.312669 1 x:0] Version release-20191213.0-48-ge013c48c78c9 I1224 17:26:54.312677 1 x:0] PID: 1 I1224 17:26:54.312685 1 x:0] UID: 65534, GID: 65534 I1224 17:26:54.312715 1 x:0] Configuration: I1224 17:26:54.313013 1 x:0] RootDir: /syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/gvisor_root I1224 17:26:54.313018 1 x:0] Platform: kvm I1224 17:26:54.313022 1 x:0] FileAccess: exclusive, overlay: true I1224 17:26:54.313043 1 x:0] Network: sandbox, logging: false I1224 17:26:54.313050 1 x:0] Strace: false, max size: 1024, syscalls: [] I1224 17:26:54.313064 1 x:0] *************************** D1224 17:26:54.315062 1 x:0] Spec: &{Version: Process:0xc0002b1a00 Root:0xc0002bcb40 Hostname: Mounts:[] Hooks: Annotations:map[] Linux: Solaris: Windows:} D1224 17:26:54.315141 1 x:0] Spec.Hooks: D1224 17:26:54.315146 1 x:0] Spec.Linux: D1224 17:26:54.315150 1 x:0] Spec.Process: &{Terminal:false ConsoleSize: User:{UID:0 GID:0 AdditionalGids:[] Username:} Args:[/init] Env:[SYZ_GVISOR_PROXY=1] Cwd:/tmp Capabilities:0xc00013a300 Rlimits:[] NoNewPrivileges:false ApparmorProfile: OOMScoreAdj: SelinuxLabel:} D1224 17:26:54.315184 1 x:0] Spec.Root: &{Path:/syzkaller/managers/kvm-proxy-overlay-sandbox/latest.tmp/workdir/instance-2/image Readonly:true} D1224 17:26:54.315198 1 x:0] Spec.Mounts: [] I1224 17:26:54.315289 1 x:0] Platform: kvm I1224 17:26:54.317202 1 x:0] excluded: virtual [7ffece397000,7ffece399000) I1224 17:26:54.317240 1 x:0] excluded: virtual [7ffece399000,7ffece39b000) I1224 17:26:54.317278 1 x:0] region: virtual [3f34354d4000,7f35b54d0000) I1224 17:26:54.317284 1 x:0] region: virtual [7ffece397000,7ffece399000) I1224 17:26:54.317293 1 x:0] region: virtual [7ffece399000,7ffece39b000) I1224 17:26:54.317300 1 x:0] physicalRegion: virtual [1000,3f34354d4000) => physical [100001000,3f35354d4000) I1224 17:26:54.317305 1 x:0] physicalRegion: virtual [7f35b54d0000,7ffece397000) => physical [3f35b54d0000,3ffece397000) I1224 17:26:54.317311 1 x:0] physicalRegion: virtual [7ffece39b000,7ffffffff000) => physical [3ffece39b000,3ffffffff000) D1224 17:26:54.423848 1 x:0] The maximum number of vCPUs is 288. runtime: failed to create new OS thread (have 7 already; errno=11) runtime: may need to increase max user processes (ulimit -u) fatal error: newosproc runtime stack: runtime.throw(0xdb3712, 0x9) GOROOT/src/runtime/panic.go:774 +0x72 runtime.newosproc(0xc0000fa380) GOROOT/src/runtime/os_linux.go:153 +0x1ba runtime.newm1(0xc0000fa380) GOROOT/src/runtime/proc.go:1853 +0xdc runtime.newm(0xde4b78, 0xc000034000) GOROOT/src/runtime/proc.go:1832 +0x8f runtime.startm(0x0, 0xc000036501) GOROOT/src/runtime/proc.go:1969 +0x12a runtime.wakep(...) GOROOT/src/runtime/proc.go:2050 runtime.resetspinning() GOROOT/src/runtime/proc.go:2430 +0x93 runtime.schedule() GOROOT/src/runtime/proc.go:2531 +0x2a0 runtime.park_m(0xc000001980) GOROOT/src/runtime/proc.go:2610 +0x9d runtime.mcall(0x0) src/runtime/asm_amd64.s:318 +0x5b goroutine 1 [runnable]: reflect.Value.NumField(0xd03a00, 0xc00044e018, 0x199, 0xc0a701) GOROOT/src/reflect/value.go:1355 +0xc4 gvisor.dev/gvisor/pkg/tcpip.fillIn(0xd03a00, 0xc00044e018, 0x199) pkg/tcpip/tcpip.go:1147 +0x58 gvisor.dev/gvisor/pkg/tcpip.fillIn(0xd35640, 0xc00044e000, 0x199) pkg/tcpip/tcpip.go:1154 +0x16e gvisor.dev/gvisor/pkg/tcpip.Stats.FillIn(0xc0000cef00, 0xc0000cef08, 0xc0000cef10, 0xc0000cef18, 0xc0000cef20, 0xc0000cef28, 0xc0000cef30, 0xc0000cef38, 0xc0000cef40, 0xc0000cef48, ...) pkg/tcpip/tcpip.go:1161 +0x131 gvisor.dev/gvisor/pkg/tcpip/stack.New(0xc000410030, 0x3, 0x3, 0xc000410060, 0x3, 0x3, 0xed8200, 0xc000243ba0, 0xc0000cef00, 0xc0000cef08, ...) pkg/tcpip/stack/stack.go:544 +0x1dc gvisor.dev/gvisor/runsc/boot.newEmptyNetworkStack(0xc000277200, 0xed8200, 0xc000243ba0, 0xed1f80, 0xc000243ba0, 0x0, 0x0, 0xc1b900, 0xc0002bd201) runsc/boot/loader.go:908 +0x3b3 gvisor.dev/gvisor/runsc/boot.New(0x7ffece381fbe, 0x2a, 0xc0002350a0, 0xc000277200, 0x3, 0xc00000e900, 0xc0000cfb58, 0x1, 0x1, 0xc0000d1a40, ...) runsc/boot/loader.go:228 +0x76c gvisor.dev/gvisor/runsc/cmd.(*Boot).Execute(0xc0001ac2d0, 0xee3540, 0xc0000ce008, 0xc00027a540, 0xc000222d60, 0x2, 0x2, 0x0) runsc/cmd/boot.go:226 +0xaa6 github.com/google/subcommands.(*Commander).Execute(0xc00013a000, 0xee3540, 0xc0000ce008, 0xc000222d60, 0x2, 0x2, 0x0) external/com_github_google_subcommands/subcommands.go:200 +0x2f9 github.com/google/subcommands.Execute(...) external/com_github_google_subcommands/subcommands.go:481 main.main() runsc/main.go:318 +0x1754 goroutine 4 [syscall]: os/signal.signal_recv(0x0) GOROOT/src/runtime/sigqueue.go:147 +0x9c os/signal.loop() GOROOT/src/os/signal/signal_unix.go:23 +0x22 created by os/signal.init.0 GOROOT/src/os/signal/signal_unix.go:29 +0x41 goroutine 5 [sync.Cond.Wait]: runtime.goparkunlock(...) GOROOT/src/runtime/proc.go:310 sync.runtime_notifyListWait(0xc00027e948, 0x0) GOROOT/src/runtime/sema.go:510 +0xf8 sync.(*Cond).Wait(0xc00027e938) GOROOT/src/sync/cond.go:56 +0x9d gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).findReclaimable(0xc00027e500, 0x0, 0x0, 0x0) pkg/sentry/pgalloc/pgalloc.go:1090 +0x95 gvisor.dev/gvisor/pkg/sentry/pgalloc.(*MemoryFile).runReclaim(0xc00027e500) pkg/sentry/pgalloc/pgalloc.go:1019 +0x6a created by gvisor.dev/gvisor/pkg/sentry/pgalloc.NewMemoryFile pkg/sentry/pgalloc/pgalloc.go:330 +0x1fd goroutine 34 [runnable]: gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater.func1(0xc000412000, 0xc0004140a0) pkg/sentry/kernel/timekeeper.go:184 created by gvisor.dev/gvisor/pkg/sentry/kernel.(*Timekeeper).startUpdater pkg/sentry/kernel/timekeeper.go:184 +0xbf D1224 17:26:55.811814 29100 x:0] Destroy sandbox "ci-gvisor-kvm-proxy-overlay-sandbox-test-1" D1224 17:26:55.811856 29100 x:0] Killing sandbox "ci-gvisor-kvm-proxy-overlay-sandbox-test-1" W1224 17:26:55.937048 29100 x:0] error destroying sandbox: D1224 17:26:55.937243 29100 x:0] Destroy container "ci-gvisor-kvm-proxy-overlay-sandbox-test-1" D1224 17:26:55.937594 29100 x:0] Killing gofer for container "ci-gvisor-kvm-proxy-overlay-sandbox-test-1", PID: 32352 W1224 17:26:56.244429 29100 x:0] FATAL ERROR: running container: creating container: waiting for sandbox to start: EOF running container: creating container: waiting for sandbox to start: EOF W1224 17:26:56.244568 29100 x:0] Failure to execute command, err: 1