Skip to content

Instantly share code, notes, and snippets.

@felixge
Last active November 26, 2024 08:05
Show Gist options
  • Save felixge/e329d091290662a136611b9fffbdd67f to your computer and use it in GitHub Desktop.
Save felixge/e329d091290662a136611b9fffbdd67f to your computer and use it in GitHub Desktop.
package main
import (
"log"
"os"
"runtime/trace"
"time"
)
func main() {
if err := trace.Start(os.Stdout); err != nil {
log.Fatal(err)
}
defer trace.Stop()
start := time.Now()
for time.Since(start) < time.Second {
onCPULoop(10 * time.Millisecond)
offCPUSleep(10 * time.Millisecond)
}
}
func onCPULoop(d time.Duration) {
start := time.Now()
for time.Since(start) < d {
// spin
}
}
func offCPUSleep(d time.Duration) {
time.Sleep(d)
}
M=8674447168 P=-1 G=-1 StateTransition Time=348065034702528 Resource=Proc(2) Reason="" ProcID=2 Undetermined->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065034702656 Resource=Goroutine(1) Reason="" GoID=1 Undetermined->Running
M=8674447168 P=2 G=1 Metric Time=348065034704704 Name="/sched/gomaxprocs:threads" Value=Uint64(10)
Stack=
runtime.traceLocker.Gomaxprocs @ 0x1029aa444
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/traceruntime.go:286
runtime.StartTrace @ 0x1029a29b7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:283
runtime/trace.Start @ 0x1029f12af
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:125
main.main @ 0x1029f1683
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:11
M=8674447168 P=2 G=1 RangeBegin Time=348065034705024 Name="stop-the-world (start trace)" Scope=Goroutine(1)
Stack=
runtime.StartTrace @ 0x1029a29c7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:284
runtime/trace.Start @ 0x1029f12af
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:125
main.main @ 0x1029f1683
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:11
M=8674447168 P=2 G=1 Metric Time=348065034705088 Name="/gc/heap/goal:bytes" Value=Uint64(4194304)
M=8674447168 P=2 G=1 StateTransition Time=348065034705152 Resource=Proc(0) Reason="" ProcID=0 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705216 Resource=Proc(1) Reason="" ProcID=1 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705280 Resource=Proc(3) Reason="" ProcID=3 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705344 Resource=Proc(4) Reason="" ProcID=4 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705408 Resource=Proc(5) Reason="" ProcID=5 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705472 Resource=Proc(6) Reason="" ProcID=6 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705536 Resource=Proc(7) Reason="" ProcID=7 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705600 Resource=Proc(8) Reason="" ProcID=8 Undetermined->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034705664 Resource=Proc(9) Reason="" ProcID=9 Undetermined->Idle
M=8674447168 P=2 G=1 Metric Time=348065034705728 Name="/sched/gomaxprocs:threads" Value=Uint64(10)
Stack=
runtime.startTheWorld @ 0x10298522b
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:1474
runtime.StartTrace @ 0x1029a2b3b
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:306
runtime/trace.Start @ 0x1029f12af
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:125
main.main @ 0x1029f1683
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:11
M=8674447168 P=2 G=1 RangeEnd Time=348065034706240 Name="stop-the-world (start trace)" Scope=Goroutine(1) Attributes=[]
M=8674447168 P=2 G=1 Metric Time=348065034708160 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2924544)
M=6130872320 P=-1 G=-1 StateTransition Time=348065034713984 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065034714624 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065034732800 Resource=Goroutine(34) Reason="" GoID=34 NotExist->Runnable
TransitionStack=
runtime.traceStartReadCPU.func1 @ 0x1029a8c93
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:42
Stack=
runtime.traceStartReadCPU @ 0x1029a8c23
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:42
runtime.StartTrace @ 0x1029a2b3f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:308
runtime/trace.Start @ 0x1029f12af
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:125
main.main @ 0x1029f1683
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:11
M=8674447168 P=2 G=1 StateTransition Time=348065034734464 Resource=Goroutine(35) Reason="" GoID=35 NotExist->Runnable
TransitionStack=
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3a73
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:957
Stack=
runtime.(*traceAdvancerState).start @ 0x1029a3a43
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:957
runtime.StartTrace @ 0x1029a2b4b
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:309
runtime/trace.Start @ 0x1029f12af
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:125
main.main @ 0x1029f1683
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:11
M=6130872320 P=-1 G=-1 StateTransition Time=348065034735360 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065034736704 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=6130872320 P=0 G=34 Metric Time=348065034748416 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2932736)
M=6130872320 P=0 G=34 StateTransition Time=348065034749120 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=8674447168 P=2 G=1 StateTransition Time=348065034753408 Resource=Goroutine(36) Reason="" GoID=36 NotExist->Runnable
TransitionStack=
runtime/trace.Start.func1 @ 0x1029f1393
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:128
Stack=
runtime/trace.Start @ 0x1029f12fb
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:128
main.main @ 0x1029f1683
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:11
M=6130872320 P=0 G=-1 StateTransition Time=348065034755328 Resource=Goroutine(35) Reason="" GoID=35 Runnable->Running
M=6130872320 P=0 G=35 Metric Time=348065034765056 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2940928)
M=6130872320 P=0 G=35 StateTransition Time=348065034765568 Resource=Goroutine(35) Reason="chan receive" GoID=35 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:960
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:960
M=6130298880 P=-1 G=-1 StateTransition Time=348065034766272 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065034771648 Resource=Goroutine(36) Reason="" GoID=36 Runnable->Running
M=6130872320 P=0 G=36 StateTransition Time=348065034772224 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=1 G=-1 StateTransition Time=348065034773312 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6129152000 P=-1 G=-1 StateTransition Time=348065034790784 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=36 StateTransition Time=348065034803200 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=36 StateTransition Time=348065034803328 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065034803392 Resource=Goroutine(36) Reason="" GoID=36 Runnable->Running
M=6130872320 P=0 G=36 StateTransition Time=348065034803776 Resource=Goroutine(36) Reason="system goroutine wait" GoID=36 Running->Waiting
TransitionStack=
runtime/trace.Start.func1 @ 0x1029f13db
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:130
Stack=
runtime/trace.Start.func1 @ 0x1029f13db
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:130
M=6130872320 P=0 G=-1 StateTransition Time=348065034804416 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065044766976 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065044774272 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065044780864 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065044781888 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065055786496 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065055787584 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065055791616 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065055818752 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065055820032 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=1 StateTransition Time=348065065795648 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=-1 G=-1 StateTransition Time=348065065805696 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065065807232 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=-1 StateTransition Time=348065065813376 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065076806656 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065076808192 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065076813248 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065076829184 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065076831168 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065078250176 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065078253312 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065078268224 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065078269824 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065086814720 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065086819008 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065086824064 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065086824960 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065097834048 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065097836160 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065097843968 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065097856832 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065097860608 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=1 StateTransition Time=348065107849408 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=-1 G=-1 StateTransition Time=348065107863872 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065107865408 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=-1 StateTransition Time=348065107872000 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065118867456 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065118869120 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065118873024 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065118884032 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065118885440 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065119624960 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065119627328 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065119631552 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065119632832 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065128874752 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065128876544 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065135746368 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065135748992 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065135752512 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065135756736 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065135757824 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=34 StateTransition Time=348065135785600 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=6130298880 P=2 G=-1 StateTransition Time=348065135786688 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065139284416 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065139285440 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065139293056 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065139303488 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065139304704 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065147177728 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065147181120 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065147185920 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065147187008 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065149293952 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065149299200 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065149302208 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065149302720 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065160302592 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065160303360 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065160305536 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065160309120 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065160310080 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=1 StateTransition Time=348065170306496 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=2 G=-1 StateTransition Time=348065170308608 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065170311104 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065170311680 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065181312192 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065181312832 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065181314560 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065181318656 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065181319552 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065191317504 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065191320320 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065191323392 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065191323904 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065202337536 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065202339904 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065202349568 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065202360576 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065202364032 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=2 G=1 StateTransition Time=348065212352448 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=2 G=-1 StateTransition Time=348065212362112 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065212368192 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065212368704 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065223358720 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065223360320 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065223373248 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065223373888 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065223376832 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065224236032 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065224238912 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065224250240 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065224251264 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065233374400 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065233375488 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065236757696 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065236758912 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065236760704 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=6130298880 P=2 G=34 StateTransition Time=348065236762688 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=6130298880 P=2 G=-1 StateTransition Time=348065236762944 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065236764992 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065236765504 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065244207872 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065244208896 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065244212096 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065244223744 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065244224704 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065249259648 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130298880 P=0 G=-1 StateTransition Time=348065249261120 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065249266880 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065249267648 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065254212800 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065254215360 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065254217728 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065254218304 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065265217984 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065265218496 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065265220480 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065265229056 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065265229824 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065275221248 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065275223808 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065275229440 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065275229952 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065286239872 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065286241856 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065286250304 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065286266048 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065286269568 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065296252608 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065296254912 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065296257536 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065296257984 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065307261248 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065307261824 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065307263680 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065307266496 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065307267200 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065307383040 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=0 G=-1 StateTransition Time=348065307384448 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065307397120 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065307397824 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065317264512 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065317266496 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065317268928 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065317269504 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065328272512 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065328273088 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065328275712 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065328278208 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065328278912 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065337004160 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065337004992 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065337009600 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=8674447168 P=2 G=34 StateTransition Time=348065337010816 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=8674447168 P=2 G=-1 StateTransition Time=348065337011648 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065337013888 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065337014464 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065338276288 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065338278464 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065338280192 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065338280704 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065349280448 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065349280896 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065349282560 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065349286720 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348065349287488 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065350610368 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=0 G=-1 StateTransition Time=348065350611648 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065350614272 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065350615104 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065359283456 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065359288832 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065359294400 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065359294848 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065370288000 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065370288576 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065370290688 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065370294016 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065370294784 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065380294272 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065380299904 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065380304896 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065380305408 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065391308736 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065391309952 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065391313536 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065391334912 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348065391335680 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065401314816 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065401317824 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065401321152 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065401321664 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065412222656 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065412223744 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065412227584 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065412231232 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065412232128 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065413331200 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130298880 P=0 G=-1 StateTransition Time=348065413333568 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065413343040 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065413343872 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065422228672 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065422232064 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065422234624 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065422235136 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065433235904 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065433237120 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065433242624 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065433252096 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348065433253184 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065437485376 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348065437487104 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=6130298880 P=1 G=-1 StateTransition Time=348065437489536 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065437491904 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065437492736 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=1 G=34 StateTransition Time=348065437493120 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=6130298880 P=1 G=-1 StateTransition Time=348065437493760 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065443244096 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065443247936 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065443251904 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065443252416 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065454253312 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065454254208 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065454257024 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065454275776 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065454276480 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065455198464 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130872320 P=0 G=-1 StateTransition Time=348065455201152 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065455227264 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348065455231360 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065464260864 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065464265088 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065464270400 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065464270912 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065475263232 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065475264384 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065475267328 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065475270080 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065475270912 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065485268928 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065485271616 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065485275072 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065485275520 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065496273792 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065496274624 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065496276352 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065496279616 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065496280448 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065506277248 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065506280000 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065506283520 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065506284032 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065517284544 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065517285632 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065517288320 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=0 G=1 StateTransition Time=348065517289728 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16ff
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:17
Stack=
main.main @ 0x1029f16ff
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:17
M=8674447168 P=0 G=-1 StateTransition Time=348065517290176 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065517297408 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065517298176 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065527291136 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065527294528 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065527298112 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065527298688 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065538303872 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065538305664 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065538312768 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065538322240 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065538328064 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=8674447168 P=1 G=-1 StateTransition Time=348065538340032 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=8674447168 P=1 G=34 StateTransition Time=348065538347648 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=8674447168 P=1 G=-1 StateTransition Time=348065538350656 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065538368320 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065538369152 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065548314688 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065548317568 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065548321152 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065548321600 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065559335488 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065559338176 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065559347520 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=0 G=1 StateTransition Time=348065559350528 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
time.Now @ 0x1029e24fb
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/time/time.go:1341
main.onCPULoop @ 0x1029f175f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:24
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
time.Now @ 0x1029e24fb
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/time/time.go:1341
main.onCPULoop @ 0x1029f175f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:24
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=0 G=-1 StateTransition Time=348065559351744 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065559361280 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065559365248 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065569352896 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065569354880 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065569359872 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065569360448 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065580372224 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065580373888 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065580382208 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065580385472 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065580386816 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065590384768 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065590392128 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065590396416 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065590396928 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065601391552 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065601393280 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065601398400 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065601404672 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065601405696 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065602836736 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=0 G=-1 StateTransition Time=348065602838784 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065602844032 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065602844800 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065611411712 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=0 G=-1 StateTransition Time=348065611420032 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065611428416 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065611429376 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065622434560 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065622436160 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065622442432 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065622453120 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065622454528 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065632445184 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065632447360 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065639360640 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065639364736 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065639368192 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065639372800 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065639373824 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=34 Metric Time=348065639405824 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2949120)
M=8674447168 P=0 G=34 StateTransition Time=348065639409920 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=8674447168 P=0 G=-1 StateTransition Time=348065639412288 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065642836416 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065642837888 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065642840960 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065642849792 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065642850816 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065650981440 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130872320 P=0 G=-1 StateTransition Time=348065650983936 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065650989056 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065650990656 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065652843456 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065652847360 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065652855360 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065652856000 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065663853248 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065663854912 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065663858688 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065663863488 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065663864576 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065673861248 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=-1 G=-1 StateTransition Time=348065673871680 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065673872640 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=-1 StateTransition Time=348065673874816 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065684898944 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065684901312 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065684908032 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065684934656 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065684935936 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065694936192 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065694941184 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065694948864 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065694949312 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065705404288 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065705405248 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065705408192 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065705425344 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065705426240 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065705496192 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=0 G=-1 StateTransition Time=348065705498624 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065705502848 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065705503616 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=1 StateTransition Time=348065715412672 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=-1 G=-1 StateTransition Time=348065715422976 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065715423616 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=0 G=-1 StateTransition Time=348065715425984 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065726432064 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065726433280 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065726436416 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065726449664 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065726450624 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065736437632 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065736438912 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065740375488 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065740378816 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=8674447168 P=0 G=-1 StateTransition Time=348065740380736 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=8674447168 P=0 G=34 StateTransition Time=348065740382976 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=8674447168 P=0 G=-1 StateTransition Time=348065740383296 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065740385472 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065740386048 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065746822208 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065746823040 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065746827392 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065746829440 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065746830208 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065752289152 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065752292544 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065752300864 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065752301696 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065756828288 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065756831296 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065756839872 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065756840448 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065767833856 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065767834304 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=2 G=-1 StateTransition Time=348065767835648 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065767841536 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065767842176 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=2 G=1 StateTransition Time=348065777839616 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=2 G=-1 StateTransition Time=348065777846080 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065777850944 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065777851520 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065788876736 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065788879360 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065788892736 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065788907200 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065788910976 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065790210176 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065790212672 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065790218176 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065790218816 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065798894720 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065798899264 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065798901824 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065798902336 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065809901952 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065809902592 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=2 G=-1 StateTransition Time=348065809904448 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065809913728 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065809914496 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=2 G=1 StateTransition Time=348065819905344 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=-1 G=-1 StateTransition Time=348065819915008 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=8674447168 P=0 G=-1 StateTransition Time=348065819915648 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=2 G=-1 StateTransition Time=348065819917440 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065830940416 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065830942912 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065830953728 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065830957248 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065830959488 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065832181504 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=8674447168 P=2 G=-1 StateTransition Time=348065832183872 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065832192832 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065832193536 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=8674447168 P=2 G=1 StateTransition Time=348065840956480 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=8674447168 P=2 G=-1 StateTransition Time=348065840959680 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=8674447168 P=2 G=-1 StateTransition Time=348065840961920 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=8674447168 P=2 G=34 StateTransition Time=348065840963648 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=8674447168 P=2 G=-1 StateTransition Time=348065840964096 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065840966400 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065840966976 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065841390656 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065841391232 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065851961344 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065851962176 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065851964288 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=0 G=1 StateTransition Time=348065851968896 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130872320 P=0 G=-1 StateTransition Time=348065851969216 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065851977664 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065851978560 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065861970368 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065861974784 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065861978432 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065861978944 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065872973952 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065872974656 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065872977280 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065872992576 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065872993600 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065882979008 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065882983488 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065882987776 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065882989248 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065893055040 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065893056704 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065893058816 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065893060928 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065893062208 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065903082624 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065903088192 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065903098752 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065903099456 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065914092992 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065914095104 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065914103424 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065914108352 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130872320 P=2 G=-1 StateTransition Time=348065914110784 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065924105984 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065924111616 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065924124480 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065924126528 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065934900928 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065934902976 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065934911296 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065934916928 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065934918592 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065936012480 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130872320 P=0 G=-1 StateTransition Time=348065936016000 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065936039744 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=8674447168 P=2 G=-1 StateTransition Time=348065936040704 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065941730496 Resource=Proc(2) Reason="" ProcID=2 Idle->Running
M=6130298880 P=2 G=-1 StateTransition Time=348065941732416 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Runnable
M=6130298880 P=2 G=-1 StateTransition Time=348065941736192 Resource=Goroutine(34) Reason="" GoID=34 Runnable->Running
M=6130298880 P=2 G=34 StateTransition Time=348065941739072 Resource=Goroutine(34) Reason="chan receive" GoID=34 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=6130298880 P=2 G=-1 StateTransition Time=348065941740480 Resource=Proc(2) Reason="" ProcID=2 Running->Idle
M=8674447168 P=-1 G=-1 StateTransition Time=348065941746304 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065941746880 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065944913280 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065944920832 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065944924608 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065944925248 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065954929152 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065954930688 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065954933888 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065954938176 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065954939328 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348065964935872 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348065964940032 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065964942208 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065964942848 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348065975839552 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348065975840512 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348065975843328 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348065975849280 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348065975850240 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065976429504 Resource=Goroutine(1) Reason="preempted" GoID=1 Running->Runnable
TransitionStack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
Stack=
main.main @ 0x1029f16df
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:18
M=6130872320 P=0 G=-1 StateTransition Time=348065976431360 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348065976438400 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348065976439040 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348065985844032 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348065985846336 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065985849280 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065985849792 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348065996850944 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348065996851520 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348065996853312 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348065996856512 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348065996857280 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=1 StateTransition Time=348066006854208 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130298880 P=0 G=-1 StateTransition Time=348066006860032 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348066006863616 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348066006864064 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348066017875648 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348066017877824 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348066017886912 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130298880 P=-1 G=-1 StateTransition Time=348066017915328 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=1 G=-1 StateTransition Time=348066017919104 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130872320 P=0 G=1 StateTransition Time=348066027888768 Resource=Goroutine(1) Reason="sleep" GoID=1 Running->Waiting
TransitionStack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
Stack=
time.Sleep @ 0x1029b69e7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go:338
main.offCPUSleep @ 0x1029f16ef
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:31
main.main @ 0x1029f16e0
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go:19
M=6130872320 P=0 G=-1 StateTransition Time=348066027889408 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130298880 P=-1 G=-1 StateTransition Time=348066035433600 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130298880 P=0 G=-1 StateTransition Time=348066035437568 Resource=Goroutine(35) Reason="" GoID=35 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348066035439296 Resource=Goroutine(35) Reason="" GoID=35 Runnable->Running
M=6130872320 P=-1 G=-1 StateTransition Time=348066035447744 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130872320 P=1 G=-1 StateTransition Time=348066035448448 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=35 Metric Time=348066035502400 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2957312)
M=6130298880 P=0 G=35 Metric Time=348066035507840 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2965504)
M=-1 P=-1 G=-1 StateTransition Time=348066035548992 Resource=Goroutine(2) Reason="" GoID=2 Undetermined->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.goparkunlock @ 0x102982c97
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:441
runtime.forcegchelper @ 0x102982c74
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:348
M=-1 P=-1 G=-1 StateTransition Time=348066035549056 Resource=Goroutine(17) Reason="" GoID=17 Undetermined->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.goparkunlock @ 0x10296f25f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:441
runtime.bgsweep @ 0x10296f23c
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcsweep.go:276
M=-1 P=-1 G=-1 StateTransition Time=348066035549120 Resource=Goroutine(18) Reason="" GoID=18 Undetermined->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.goparkunlock @ 0x10296cd6b
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:441
runtime.(*scavengerState).park @ 0x10296cd50
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcscavenge.go:425
runtime.bgscavenge @ 0x10296d2a3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcscavenge.go:653
M=-1 P=-1 G=-1 StateTransition Time=348066035549184 Resource=Goroutine(33) Reason="" GoID=33 Undetermined->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.runfinq @ 0x1029623c7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mfinal.go:196
M=-1 P=-1 G=-1 Sync Time=348066035549185
M=6130298880 P=0 G=35 StateTransition Time=348066035549186 Resource=Proc(0) Reason="" ProcID=0 Running->Running
M=6130298880 P=0 G=35 StateTransition Time=348066035549187 Resource=Goroutine(35) Reason="" GoID=35 Running->Running
M=6130298880 P=0 G=35 Metric Time=348066035549188 Name="/sched/gomaxprocs:threads" Value=Uint64(10)
Stack=
runtime.traceLocker.Gomaxprocs @ 0x1029aa444
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/traceruntime.go:286
runtime.traceAdvance @ 0x1029b6c47
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:452
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aaf
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:963
M=6130298880 P=0 G=35 Metric Time=348066035556544 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2973696)
M=6130298880 P=0 G=35 Metric Time=348066035644032 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2981888)
M=6130298880 P=0 G=35 StateTransition Time=348066035707456 Resource=Proc(1) Reason="" ProcID=1 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035708160 Resource=Proc(2) Reason="" ProcID=2 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035708800 Resource=Proc(3) Reason="" ProcID=3 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035709312 Resource=Proc(4) Reason="" ProcID=4 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035709952 Resource=Proc(5) Reason="" ProcID=5 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035710528 Resource=Proc(6) Reason="" ProcID=6 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035711104 Resource=Proc(7) Reason="" ProcID=7 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035711680 Resource=Proc(8) Reason="" ProcID=8 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035712320 Resource=Proc(9) Reason="" ProcID=9 Idle->Idle
M=6130298880 P=0 G=35 StateTransition Time=348066035718912 Resource=Goroutine(35) Reason="sync" GoID=35 Running->Waiting
TransitionStack=
runtime.traceAdvance @ 0x1029b7264
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:650
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aaf
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:963
Stack=
runtime.traceAdvance @ 0x1029b7264
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:650
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aaf
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:963
M=6130298880 P=0 G=-1 StateTransition Time=348066035719168 Resource=Goroutine(36) Reason="" GoID=36 Waiting->Waiting
M=6130298880 P=0 G=-1 StateTransition Time=348066035719232 Resource=Goroutine(36) Reason="" GoID=36 Waiting->Runnable
M=6130298880 P=0 G=-1 StateTransition Time=348066035720512 Resource=Goroutine(36) Reason="" GoID=36 Runnable->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035726272 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=8674447168 P=-1 G=-1 StateTransition Time=348066035734528 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=8674447168 P=1 G=-1 StateTransition Time=348066035735296 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=36 StateTransition Time=348066035746688 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035747520 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035749952 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035750208 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035752512 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035752704 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035754496 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035754624 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035756992 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035757120 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035758912 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035759040 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035760704 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035760896 Resource=Goroutine(36) Reason="" GoID=36 Running->Syscall
TransitionStack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
Stack=
syscall.write @ 0x1029d7aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go:1709
syscall.Write @ 0x1029e431f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go:211
internal/poll.ignoringEINTRIO @ 0x1029e4310
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:745
internal/poll.(*FD).Write @ 0x1029e4190
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go:381
os.(*File).write @ 0x1029e5e37
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go:46
os.(*File).Write @ 0x1029e5e30
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go:195
runtime/trace.Start.func1 @ 0x1029f13d7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:134
M=6130298880 P=0 G=36 StateTransition Time=348066035772032 Resource=Goroutine(36) Reason="" GoID=36 Syscall->Running
M=6130298880 P=0 G=36 StateTransition Time=348066035772480 Resource=Goroutine(35) Reason="" GoID=35 Waiting->Runnable
Stack=
@ 0x0
:0
M=6130298880 P=0 G=36 StateTransition Time=348066035774016 Resource=Goroutine(36) Reason="system goroutine wait" GoID=36 Running->Waiting
TransitionStack=
runtime/trace.Start.func1 @ 0x1029f13db
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:130
Stack=
runtime/trace.Start.func1 @ 0x1029f13db
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go:130
M=6130298880 P=0 G=-1 StateTransition Time=348066035774272 Resource=Goroutine(35) Reason="" GoID=35 Runnable->Running
M=8674447168 P=-1 G=-1 StateTransition Time=348066035775360 Resource=Proc(1) Reason="" ProcID=1 Idle->Running
M=6130298880 P=0 G=35 StateTransition Time=348066035775680 Resource=Goroutine(35) Reason="chan receive" GoID=35 Running->Waiting
TransitionStack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:960
Stack=
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.(*traceAdvancerState).start.func1 @ 0x1029a3aa7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:960
M=8674447168 P=1 G=-1 StateTransition Time=348066035775872 Resource=Proc(1) Reason="" ProcID=1 Running->Idle
M=6130298880 P=0 G=-1 StateTransition Time=348066035776192 Resource=Proc(0) Reason="" ProcID=0 Running->Idle
M=6130872320 P=-1 G=-1 StateTransition Time=348066038200512 Resource=Proc(0) Reason="" ProcID=0 Idle->Running
M=6130872320 P=0 G=-1 StateTransition Time=348066038200896 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Waiting
M=6130872320 P=0 G=-1 StateTransition Time=348066038201024 Resource=Goroutine(1) Reason="" GoID=1 Waiting->Runnable
M=6130872320 P=0 G=-1 StateTransition Time=348066038204608 Resource=Goroutine(1) Reason="" GoID=1 Runnable->Running
M=6130872320 P=0 G=1 Metric Time=348066038208640 Name="/memory/classes/heap/objects:bytes" Value=Uint64(2990080)
M=-1 P=-1 G=-1 StateTransition Time=348066038209600 Resource=Goroutine(2) Reason="" GoID=2 Waiting->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.goparkunlock @ 0x102982c97
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:441
runtime.forcegchelper @ 0x102982c74
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:348
M=-1 P=-1 G=-1 StateTransition Time=348066038209664 Resource=Goroutine(17) Reason="" GoID=17 Waiting->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.goparkunlock @ 0x10296f25f
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:441
runtime.bgsweep @ 0x10296f23c
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcsweep.go:276
M=-1 P=-1 G=-1 StateTransition Time=348066038209728 Resource=Goroutine(18) Reason="" GoID=18 Waiting->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.goparkunlock @ 0x10296cd6b
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:441
runtime.(*scavengerState).park @ 0x10296cd50
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcscavenge.go:425
runtime.bgscavenge @ 0x10296d2a3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcscavenge.go:653
M=-1 P=-1 G=-1 StateTransition Time=348066038209792 Resource=Goroutine(33) Reason="" GoID=33 Waiting->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.runfinq @ 0x1029623c7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mfinal.go:196
M=-1 P=-1 G=-1 StateTransition Time=348066038209856 Resource=Goroutine(34) Reason="" GoID=34 Waiting->Waiting
Stack=
runtime.gopark @ 0x1029b41a7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go:435
runtime.chanrecv @ 0x10295550b
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:664
runtime.chanrecv1 @ 0x1029550d3
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go:506
runtime.(*wakeableSleep).sleep @ 0x1029a3bf7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go:1023
runtime.traceStartReadCPU.func1 @ 0x1029a8cd7
/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go:54
M=-1 P=-1 G=-1 Sync Time=348066038209857
EventBatch gen=1 m=18446744073709551615 time=5438531803925 size=5
Frequency freq=15625000
EventBatch gen=1 m=6130872320 time=5438516167358 size=781
ProcStart dt=48 p=0 p_seq=1
ProcStop dt=10
ProcStart dt=324 p=0 p_seq=2
GoStart dt=21 g=34 g_seq=1
HeapAlloc dt=183 heapalloc_value=2932736
GoBlock dt=11 reason_string=12 stack=8
GoStart dt=97 g=35 g_seq=1
HeapAlloc dt=152 heapalloc_value=2940928
GoBlock dt=8 reason_string=12 stack=11
GoStart dt=95 g=36 g_seq=1
GoSyscallBegin dt=9 p_seq=3 stack=12
ProcStart dt=484 p=0 p_seq=5
GoSyscallEndBlocked dt=2
GoStart dt=1 g=36 g_seq=2
GoBlock dt=6 reason_string=15 stack=13
ProcStop dt=10
ProcStart dt=679122 p=0 p_seq=9
ProcStop dt=25
ProcStart dt=646277 p=0 p_seq=13
ProcStop dt=20
ProcStart dt=430517 p=0 p_seq=16
ProcStop dt=17
ProcStart dt=1204113 p=0 p_seq=21
ProcStop dt=16
ProcStart dt=390869 p=2 p_seq=19
ProcStop dt=12
ProcStart dt=908273 p=2 p_seq=23
ProcStop dt=11
ProcStart dt=462751 p=1 p_seq=2
ProcStop dt=9
ProcStart dt=212497 p=1 p_seq=4
ProcStop dt=13
ProcStart dt=980124 p=1 p_seq=8
ProcStop dt=13
ProcStart dt=377313 p=2 p_seq=26
ProcStop dt=13
ProcStart dt=89987 p=0 p_seq=42
ProcStop dt=8
ProcStart dt=171889 p=0 p_seq=43
GoUnblock dt=14 g=1 g_seq=47 stack=0
GoStart dt=44 g=1 g_seq=48
GoStop dt=14710 reason_string=16 stack=15
GoStart dt=42 g=1 g_seq=49
GoBlock dt=141558 reason_string=19 stack=14
ProcStop dt=66
ProcStart dt=171953 p=1 p_seq=13
ProcStop dt=13
ProcStart dt=156315 p=0 p_seq=46
ProcStop dt=7
ProcStart dt=171848 p=0 p_seq=47
GoUnblock dt=13 g=1 g_seq=52 stack=0
GoStart dt=27 g=1 g_seq=53
GoBlock dt=156264 reason_string=19 stack=14
ProcStop dt=43
ProcStart dt=172147 p=1 p_seq=15
ProcStop dt=12
ProcStart dt=156249 p=0 p_seq=50
ProcStop dt=9
ProcStart dt=171956 p=0 p_seq=51
GoUnblock dt=28 g=1 g_seq=57 stack=0
GoStart dt=111 g=1 g_seq=58
GoBlock dt=156280 reason_string=19 stack=14
ProcStop dt=45
ProcStart dt=172558 p=2 p_seq=28
ProcStop dt=62
ProcStart dt=156166 p=0 p_seq=54
ProcStop dt=9
ProcStart dt=172059 p=0 p_seq=55
GoUnblock dt=26 g=1 g_seq=62 stack=0
GoStart dt=130 g=1 g_seq=63
GoBlock dt=156290 reason_string=19 stack=14
ProcStop dt=115
ProcStart dt=172071 p=2 p_seq=30
ProcStop dt=16
ProcStart dt=156605 p=0 p_seq=58
ProcStop dt=15
ProcStart dt=171956 p=0 p_seq=59
GoUnblock dt=25 g=1 g_seq=67 stack=0
GoStart dt=98 g=1 g_seq=68
GoBlock dt=156293 reason_string=19 stack=14
ProcStop dt=34
ProcStart dt=108210 p=2 p_seq=33
ProcStop dt=16
ProcStart dt=54103 p=0 p_seq=61
GoUnblock dt=23 g=1 g_seq=69 stack=0
GoStart dt=48 g=1 g_seq=70
GoStop dt=127195 reason_string=16 stack=15
GoStart dt=39 g=1 g_seq=71
GoBlock dt=29055 reason_string=19 stack=14
ProcStop dt=61
ProcStart dt=172127 p=2 p_seq=36
ProcStop dt=17
ProcStart dt=156361 p=2 p_seq=37
ProcStop dt=15
ProcStart dt=172286 p=0 p_seq=64
GoUnblock dt=37 g=1 g_seq=74 stack=0
GoStart dt=105 g=1 g_seq=75
GoBlock dt=156690 reason_string=19 stack=14
ProcStop dt=78
ProcStart dt=163815 p=2 p_seq=39
ProcStop dt=14
ProcStart dt=156199 p=2 p_seq=41
ProcStop dt=10
ProcStart dt=172007 p=0 p_seq=67
GoUnblock dt=19 g=1 g_seq=79 stack=0
GoStart dt=49 g=1 g_seq=80
GoBlock dt=156269 reason_string=19 stack=14
ProcStop dt=20
ProcStart dt=61665 p=2 p_seq=43
ProcStop dt=9
ProcStart dt=100678 p=0 p_seq=69
ProcStop dt=12
ProcStart dt=156401 p=2 p_seq=45
ProcStop dt=9
ProcStart dt=171772 p=2 p_seq=46
GoUnblock dt=7 g=1 g_seq=84 stack=0
GoStart dt=21 g=1 g_seq=85
GoBlock dt=156312 reason_string=19 stack=14
ProcStop dt=101
ProcStart dt=172830 p=0 p_seq=72
ProcStop dt=59
ProcStart dt=156107 p=2 p_seq=49
ProcStop dt=8
ProcStart dt=171869 p=2 p_seq=50
GoUnblock dt=10 g=1 g_seq=89 stack=0
GoStart dt=29 g=1 g_seq=90
GoBlock dt=156264 reason_string=19 stack=14
ProcStop dt=189
ProcStart dt=172497 p=0 p_seq=76
ProcStop dt=35
ProcStart dt=162987 p=0 p_seq=79
ProcStop dt=9
ProcStart dt=165158 p=0 p_seq=80
GoUnblock dt=13 g=1 g_seq=94 stack=0
GoStart dt=33 g=1 g_seq=95
GoStop dt=72 reason_string=16 stack=15
GoStart dt=5 g=1 g_seq=96
GoBlock dt=156268 reason_string=19 stack=14
ProcStop dt=69
ProcStart dt=172153 p=2 p_seq=53
ProcStop dt=16
ProcStart dt=156159 p=0 p_seq=83
ProcStop dt=23
ProcStart dt=157278 p=0 p_seq=84
GoUnblock dt=26 g=1 g_seq=99 stack=0
GoStart dt=33 g=1 g_seq=100
GoBlock dt=156622 reason_string=19 stack=14
ProcStop dt=87
ProcStart dt=172190 p=2 p_seq=55
ProcStop dt=38
ProcStart dt=156464 p=0 p_seq=87
ProcStop dt=32
ProcStart dt=168350 p=0 p_seq=88
GoUnblock dt=32 g=1 g_seq=103 stack=0
GoStart dt=130 g=1 g_seq=104
GoStop dt=17206 reason_string=16 stack=15
GoStart dt=55 g=1 g_seq=105
GoBlock dt=139020 reason_string=19 stack=14
ProcStop dt=118
ProcStart dt=156521 p=1 p_seq=18
ProcStop dt=18
ProcStart dt=156295 p=0 p_seq=91
ProcStop dt=10
ProcStart dt=170261 p=0 p_seq=92
GoUnblock dt=15 g=1 g_seq=108 stack=0
GoStart dt=44 g=1 g_seq=109
GoStop dt=9159 reason_string=16 stack=15
GoStart dt=29 g=1 g_seq=110
GoBlock dt=147073 reason_string=19 stack=14
ProcStop dt=36
ProcStart dt=172034 p=1 p_seq=21
ProcStop dt=12
ProcStart dt=156349 p=0 p_seq=95
ProcStop dt=7
ProcStart dt=172056 p=0 p_seq=96
GoUnblock dt=34 g=1 g_seq=113 stack=0
GoStart dt=142 g=1 g_seq=114
GoBlock dt=156279 reason_string=19 stack=14
ProcStop dt=10
ProcStart dt=118099 p=1 p_seq=23
ProcStop dt=11
EventBatch gen=1 m=6130298880 time=5438516168036 size=733
ProcStart dt=187 p=1 p_seq=1
ProcStop dt=110
ProcStart dt=156368 p=2 p_seq=1
ProcStop dt=16
ProcStart dt=171947 p=2 p_seq=2
GoUnblock dt=17 g=1 g_seq=1 stack=0
GoStart dt=63 g=1 g_seq=2
GoBlock dt=156313 reason_string=19 stack=14
ProcStop dt=277
ProcStart dt=172122 p=0 p_seq=8
ProcStop dt=31
ProcStart dt=156139 p=2 p_seq=4
ProcStop dt=14
ProcStart dt=172017 p=2 p_seq=5
GoUnblock dt=33 g=1 g_seq=6 stack=0
GoStart dt=122 g=1 g_seq=7
GoBlock dt=156335 reason_string=19 stack=14
ProcStop dt=353
ProcStart dt=172063 p=0 p_seq=12
ProcStop dt=22
ProcStart dt=263452 p=2 p_seq=7
GoUnblock dt=41 g=34 g_seq=2 stack=0
GoStart dt=55 g=34 g_seq=3
GoBlock dt=517 reason_string=12 stack=8
ProcStop dt=17
ProcStart dt=54950 p=0 p_seq=15
ProcStop dt=19
ProcStart dt=156211 p=2 p_seq=9
ProcStop dt=8
ProcStart dt=171873 p=2 p_seq=10
GoUnblock dt=12 g=1 g_seq=14 stack=0
GoStart dt=34 g=1 g_seq=15
GoBlock dt=156265 reason_string=19 stack=14
ProcStop dt=33
ProcStart dt=172032 p=0 p_seq=18
ProcStop dt=14
ProcStart dt=156310 p=2 p_seq=13
ProcStop dt=8
ProcStart dt=172088 p=2 p_seq=14
GoUnblock dt=37 g=1 g_seq=18 stack=0
GoStart dt=151 g=1 g_seq=19
GoBlock dt=156295 reason_string=19 stack=14
ProcStop dt=151
ProcStart dt=172059 p=0 p_seq=20
ProcStop dt=46
ProcStart dt=209076 p=2 p_seq=17
GoUnblock dt=19 g=34 g_seq=4 stack=0
GoStart dt=28 g=34 g_seq=5
GoBlock dt=31 reason_string=12 stack=8
ProcStop dt=4
ProcStart dt=116327 p=0 p_seq=23
GoUnblock dt=16 g=1 g_seq=23 stack=0
GoStart dt=50 g=1 g_seq=24
GoStop dt=78868 reason_string=16 stack=15
GoStart dt=23 g=1 g_seq=25
GoBlock dt=77370 reason_string=19 stack=14
ProcStop dt=40
ProcStart dt=172089 p=2 p_seq=20
ProcStop dt=12
ProcStart dt=156244 p=0 p_seq=26
ProcStop dt=8
ProcStart dt=172030 p=0 p_seq=27
GoUnblock dt=31 g=1 g_seq=28 stack=0
GoStart dt=132 g=1 g_seq=29
GoBlock dt=156286 reason_string=19 stack=14
ProcStop dt=36
ProcStart dt=172056 p=2 p_seq=22
ProcStop dt=11
ProcStart dt=156277 p=0 p_seq=30
ProcStop dt=9
ProcStart dt=171922 p=0 p_seq=31
GoUnblock dt=9 g=1 g_seq=33 stack=0
GoStart dt=41 g=1 g_seq=34
GoBlock dt=156259 reason_string=19 stack=14
ProcStop dt=34
ProcStart dt=172004 p=1 p_seq=3
ProcStop dt=12
ProcStart dt=156358 p=0 p_seq=34
ProcStop dt=7
ProcStart dt=171768 p=0 p_seq=35
GoUnblock dt=9 g=1 g_seq=38 stack=0
GoStart dt=33 g=1 g_seq=39
GoBlock dt=156306 reason_string=19 stack=14
ProcStop dt=88
ProcStart dt=172422 p=1 p_seq=6
ProcStop dt=12
ProcStart dt=156023 p=0 p_seq=38
ProcStop dt=8
ProcStart dt=170328 p=0 p_seq=39
GoUnblock dt=17 g=1 g_seq=42 stack=0
GoStart dt=60 g=1 g_seq=43
GoStop dt=17244 reason_string=16 stack=15
GoStart dt=37 g=1 g_seq=44
GoBlock dt=138986 reason_string=19 stack=14
ProcStop dt=53
ProcStart dt=172188 p=1 p_seq=9
ProcStop dt=17
ProcStart dt=66128 p=1 p_seq=10
GoUnblock dt=27 g=34 g_seq=8 stack=0
GoStart dt=38 g=34 g_seq=9
GoBlock dt=56 reason_string=12 stack=8
ProcStop dt=10
ProcStart dt=277086 p=1 p_seq=12
ProcStop dt=64
ProcStart dt=1299015 p=2 p_seq=27
ProcStop dt=13
ProcStart dt=1007420 p=2 p_seq=31
ProcStop dt=12
ProcStart dt=752254 p=2 p_seq=35
ProcStop dt=25
ProcStart dt=851753 p=2 p_seq=40
ProcStop dt=12
ProcStart dt=731207 p=0 p_seq=70
ProcStop dt=13
ProcStart dt=592445 p=0 p_seq=73
ProcStop dt=10
ProcStart dt=655844 p=0 p_seq=77
ProcStop dt=11
ProcStart dt=137076 p=0 p_seq=78
ProcStop dt=9
ProcStart dt=172042 p=2 p_seq=52
ProcStop dt=14
ProcStart dt=156248 p=0 p_seq=81
ProcStop dt=8
ProcStart dt=171797 p=0 p_seq=82
GoUnblock dt=11 g=1 g_seq=97 stack=0
GoStart dt=41 g=1 g_seq=98
GoBlock dt=156277 reason_string=19 stack=14
ProcStop dt=70
ProcStart dt=157460 p=2 p_seq=54
ProcStop dt=20
ProcStart dt=156821 p=0 p_seq=85
ProcStop dt=11
ProcStart dt=171774 p=0 p_seq=86
GoUnblock dt=33 g=1 g_seq=101 stack=0
GoStart dt=130 g=1 g_seq=102
GoBlock dt=156290 reason_string=19 stack=14
ProcStop dt=88
ProcStart dt=168833 p=2 p_seq=56
ProcStop dt=26
ProcStart dt=106436 p=2 p_seq=58
GoUnblock dt=30 g=34 g_seq=18 stack=0
GoStart dt=59 g=34 g_seq=19
GoBlock dt=45 reason_string=12 stack=8
ProcStop dt=22
ProcStart dt=49752 p=0 p_seq=89
ProcStop dt=10
ProcStart dt=156311 p=0 p_seq=90
GoUnblock dt=24 g=1 g_seq=106 stack=0
GoStart dt=50 g=1 g_seq=107
GoBlock dt=156281 reason_string=19 stack=14
ProcStop dt=65
ProcStart dt=170457 p=1 p_seq=19
ProcStop dt=15
ProcStart dt=156235 p=0 p_seq=93
ProcStop dt=8
ProcStart dt=171893 p=0 p_seq=94
GoUnblock dt=9 g=1 g_seq=111 stack=0
GoStart dt=28 g=1 g_seq=112
GoBlock dt=156264 reason_string=19 stack=14
ProcStop dt=91
ProcStart dt=172739 p=1 p_seq=22
ProcStop dt=59
ProcStart dt=273664 p=0 p_seq=97
GoUnblock dt=62 g=35 g_seq=2 stack=0
GoStart dt=27 g=35 g_seq=3
HeapAlloc dt=986 heapalloc_value=2957312
HeapAlloc dt=85 heapalloc_value=2965504
EventBatch gen=1 m=6129152000 time=5438516168541 size=9
ProcSteal dt=65 p=0 p_seq=4 m=6130872320
EventBatch gen=1 m=8674447168 time=5438516167209 size=1091
ProcStatus dt=18 p=2 pstatus=1
GoStatus dt=2 g=1 m=8674447168 gstatus=2
ProcsChange dt=32 procs_value=10 stack=1
STWBegin dt=5 kind_string=23 stack=2
HeapGoal dt=1 heapgoal_value=4194304
ProcStatus dt=1 p=0 pstatus=2
ProcStatus dt=1 p=1 pstatus=2
ProcStatus dt=1 p=3 pstatus=2
ProcStatus dt=1 p=4 pstatus=2
ProcStatus dt=1 p=5 pstatus=2
ProcStatus dt=1 p=6 pstatus=2
ProcStatus dt=1 p=7 pstatus=2
ProcStatus dt=1 p=8 pstatus=2
ProcStatus dt=1 p=9 pstatus=2
ProcsChange dt=1 procs_value=10 stack=3
STWEnd dt=8
HeapAlloc dt=30 heapalloc_value=2924544
GoCreate dt=385 new_g=34 new_stack=4 stack=5
GoCreate dt=26 new_g=35 new_stack=6 stack=7
GoCreate dt=296 new_g=36 new_stack=9 stack=10
GoBlock dt=156462 reason_string=19 stack=14
ProcStop dt=114
ProcStart dt=172570 p=0 p_seq=6
ProcStop dt=20
ProcStart dt=156026 p=0 p_seq=7
ProcStop dt=24
ProcStart dt=171866 p=2 p_seq=3
GoUnblock dt=24 g=1 g_seq=3 stack=0
GoStart dt=79 g=1 g_seq=4
GoStop dt=22452 reason_string=16 stack=15
GoStart dt=49 g=1 g_seq=5
GoBlock dt=133772 reason_string=19 stack=14
ProcStop dt=67
ProcStart dt=172466 p=0 p_seq=10
ProcStop dt=59
ProcStart dt=156301 p=0 p_seq=11
ProcStop dt=24
ProcStart dt=171907 p=2 p_seq=6
GoUnblock dt=26 g=1 g_seq=8 stack=0
GoStart dt=61 g=1 g_seq=9
GoStop dt=11749 reason_string=16 stack=15
GoStart dt=37 g=1 g_seq=10
GoBlock dt=144491 reason_string=19 stack=14
ProcStop dt=28
ProcStart dt=107503 p=0 p_seq=14
ProcStop dt=17
ProcStart dt=55103 p=2 p_seq=8
GoUnblock dt=16 g=1 g_seq=11 stack=0
GoStart dt=119 g=1 g_seq=12
GoStop dt=123198 reason_string=16 stack=15
GoStart dt=53 g=1 g_seq=13
GoBlock dt=33013 reason_string=19 stack=14
ProcStop dt=82
ProcStart dt=172030 p=0 p_seq=17
ProcStop dt=15
ProcStart dt=156266 p=2 p_seq=11
ProcStop dt=9
ProcStart dt=171883 p=2 p_seq=12
GoUnblock dt=10 g=1 g_seq=16 stack=0
GoStart dt=27 g=1 g_seq=17
GoBlock dt=156296 reason_string=19 stack=14
ProcStop dt=44
ProcStart dt=172504 p=0 p_seq=19
ProcStop dt=54
ProcStart dt=156315 p=2 p_seq=15
ProcStop dt=8
ProcStart dt=171719 p=2 p_seq=16
GoUnblock dt=25 g=1 g_seq=20 stack=0
GoStart dt=202 g=1 g_seq=21
GoStop dt=13481 reason_string=16 stack=15
GoStart dt=45 g=1 g_seq=22
GoBlock dt=142742 reason_string=19 stack=14
ProcStop dt=17
ProcStart dt=52961 p=0 p_seq=22
ProcStop dt=8
ProcStart dt=116535 p=2 p_seq=18
ProcStop dt=15
ProcStart dt=156141 p=0 p_seq=24
ProcStop dt=9
ProcStart dt=171870 p=0 p_seq=25
GoUnblock dt=8 g=1 g_seq=26 stack=0
GoStart dt=31 g=1 g_seq=27
GoBlock dt=156262 reason_string=19 stack=14
ProcStop dt=40
ProcStart dt=172535 p=2 p_seq=21
ProcStop dt=55
ProcStart dt=156062 p=0 p_seq=28
ProcStop dt=7
ProcStart dt=171926 p=0 p_seq=29
GoUnblock dt=9 g=1 g_seq=30 stack=0
GoStart dt=29 g=1 g_seq=31
GoStop dt=1865 reason_string=16 stack=15
GoStart dt=22 g=1 g_seq=32
GoBlock dt=154376 reason_string=19 stack=14
ProcStop dt=31
ProcStart dt=172058 p=2 p_seq=24
ProcStop dt=11
ProcStart dt=136332 p=2 p_seq=25
GoUnblock dt=13 g=34 g_seq=6 stack=0
GoStart dt=72 g=34 g_seq=7
GoBlock dt=19 reason_string=12 stack=8
ProcStop dt=13
ProcStart dt=19821 p=0 p_seq=32
ProcStop dt=8
ProcStart dt=171871 p=0 p_seq=33
GoUnblock dt=7 g=1 g_seq=35 stack=0
GoStart dt=26 g=1 g_seq=36
GoStop dt=20747 reason_string=16 stack=15
GoStart dt=20 g=1 g_seq=37
GoBlock dt=135497 reason_string=19 stack=14
ProcStop dt=84
ProcStart dt=171956 p=1 p_seq=5
ProcStop dt=12
ProcStart dt=156408 p=0 p_seq=36
ProcStop dt=8
ProcStart dt=171927 p=0 p_seq=37
GoUnblock dt=19 g=1 g_seq=40 stack=0
GoStart dt=56 g=1 g_seq=41
GoBlock dt=156270 reason_string=19 stack=14
ProcStop dt=47
ProcStart dt=170522 p=1 p_seq=7
ProcStop dt=14
ProcStart dt=156289 p=0 p_seq=40
ProcStop dt=8
ProcStart dt=171887 p=0 p_seq=41
GoUnblock dt=19 g=1 g_seq=45 stack=0
GoStart dt=86 g=1 g_seq=46
GoBlock dt=156273 reason_string=19 stack=14
ProcStop dt=60
ProcStart dt=172310 p=1 p_seq=11
ProcStop dt=11
ProcStart dt=156155 p=0 p_seq=44
ProcStop dt=8
ProcStart dt=171755 p=0 p_seq=45
GoUnblock dt=18 g=1 g_seq=50 stack=0
GoStart dt=46 g=1 g_seq=51
GoBlock dt=156275 reason_string=19 stack=14
ProcStop dt=42
ProcStart dt=172000 p=1 p_seq=14
ProcStop dt=13
ProcStart dt=156298 p=0 p_seq=48
ProcStop dt=8
ProcStart dt=171883 p=0 p_seq=49
GoUnblock dt=17 g=1 g_seq=54 stack=0
GoStart dt=42 g=1 g_seq=55
GoStop dt=22 reason_string=16 stack=16
GoStart dt=7 g=1 g_seq=56
GoBlock dt=156265 reason_string=19 stack=14
ProcStop dt=53
ProcStart dt=172308 p=1 p_seq=16
GoUnblock dt=91 g=34 g_seq=10 stack=0
GoStart dt=187 g=34 g_seq=11
GoBlock dt=119 reason_string=12 stack=8
ProcStop dt=47
ProcStart dt=155789 p=0 p_seq=52
ProcStop dt=7
ProcStart dt=172092 p=0 p_seq=53
GoUnblock dt=42 g=1 g_seq=59 stack=0
GoStart dt=146 g=1 g_seq=60
GoStop dt=47 reason_string=16 stack=17
GoStart dt=19 g=1 g_seq=61
GoBlock dt=156268 reason_string=19 stack=14
ProcStop dt=31
ProcStart dt=172353 p=2 p_seq=29
ProcStop dt=21
ProcStart dt=156400 p=0 p_seq=56
ProcStop dt=8
ProcStart dt=171791 p=0 p_seq=57
GoUnblock dt=27 g=1 g_seq=64 stack=0
GoStart dt=80 g=1 g_seq=65
GoStop dt=22474 reason_string=16 stack=15
GoStart dt=32 g=1 g_seq=66
GoBlock dt=133952 reason_string=19 stack=14
ProcStop dt=130
ProcStart dt=172392 p=2 p_seq=32
ProcStop dt=22
ProcStart dt=264158 p=0 p_seq=60
GoUnblock dt=64 g=34 g_seq=12 stack=0
GoStart dt=54 g=34 g_seq=13
HeapAlloc dt=588 heapalloc_value=2949120
GoBlock dt=64 reason_string=12 stack=8
ProcStop dt=37
ProcStart dt=53711 p=2 p_seq=34
ProcStop dt=16
ProcStart dt=156321 p=0 p_seq=62
ProcStop dt=10
ProcStart dt=171832 p=0 p_seq=63
GoUnblock dt=26 g=1 g_seq=72 stack=0
GoStart dt=59 g=1 g_seq=73
GoBlock dt=156290 reason_string=19 stack=14
ProcStop dt=212
ProcStart dt=172810 p=2 p_seq=38
ProcStop dt=20
ProcStart dt=156452 p=0 p_seq=65
ProcStop dt=7
ProcStart dt=163359 p=0 p_seq=66
GoUnblock dt=15 g=1 g_seq=76 stack=0
GoStart dt=46 g=1 g_seq=77
GoStop dt=1375 reason_string=16 stack=15
GoStart dt=38 g=1 g_seq=78
GoBlock dt=154907 reason_string=19 stack=14
ProcStop dt=208
ProcStart dt=172245 p=2 p_seq=42
ProcStop dt=15
ProcStart dt=217576 p=0 p_seq=68
GoUnblock dt=52 g=34 g_seq=14 stack=0
GoStart dt=30 g=34 g_seq=15
GoBlock dt=35 reason_string=12 stack=8
ProcStop dt=5
ProcStart dt=100608 p=2 p_seq=44
GoUnblock dt=13 g=1 g_seq=81 stack=0
GoStart dt=68 g=1 g_seq=82
GoStop dt=85340 reason_string=16 stack=15
GoStart dt=53 g=1 g_seq=83
GoBlock dt=70871 reason_string=19 stack=14
ProcStop dt=47
ProcStart dt=172035 p=0 p_seq=71
ProcStop dt=10
ProcStart dt=156387 p=2 p_seq=47
ProcStop dt=9
ProcStart dt=172269 p=2 p_seq=48
GoUnblock dt=41 g=1 g_seq=86 stack=0
GoStart dt=209 g=1 g_seq=87
GoStop dt=20585 reason_string=16 stack=15
GoStart dt=39 g=1 g_seq=88
GoBlock dt=135657 reason_string=19 stack=14
ProcStop dt=71
ProcStart dt=172101 p=0 p_seq=74
ProcStop dt=12
ProcStart dt=156258 p=0 p_seq=75
ProcStop dt=10
ProcStart dt=172262 p=2 p_seq=51
GoUnblock dt=39 g=1 g_seq=91 stack=0
GoStart dt=169 g=1 g_seq=92
GoStop dt=19184 reason_string=16 stack=15
GoStart dt=37 g=1 g_seq=93
GoBlock dt=137072 reason_string=19 stack=14
GoUnblock dt=50 g=34 g_seq=16 stack=0
GoStart dt=35 g=34 g_seq=17
GoBlock dt=27 reason_string=12 stack=8
ProcStop dt=7
ProcStart dt=1485557 p=2 p_seq=57
ProcStop dt=15
ProcStart dt=89150 p=1 p_seq=17
ProcStop dt=9
ProcStart dt=542055 p=1 p_seq=20
ProcStop dt=10
EventBatch gen=1 m=18446744073709551615 time=5438531805410 size=60
GoStatusStack dt=43 g=2 m=18446744073709551615 gstatus=4 stack=18
GoStatusStack dt=1 g=17 m=18446744073709551615 gstatus=4 stack=19
GoStatusStack dt=1 g=18 m=18446744073709551615 gstatus=4 stack=20
GoStatusStack dt=1 g=33 m=18446744073709551615 gstatus=4 stack=21
EventBatch gen=1 m=18446744073709551615 time=5438531805990 size=565
Stacks
Stack id=1 nframes=4
pc=4338656324 func=24 file=25 line=286
pc=4338624951 func=26 file=27 line=283
pc=4338946735 func=28 file=29 line=125
pc=4338947715 func=30 file=31 line=11
Stack id=3 nframes=4
pc=4338504235 func=32 file=33 line=1474
pc=4338625339 func=26 file=27 line=306
pc=4338946735 func=28 file=29 line=125
pc=4338947715 func=30 file=31 line=11
Stack id=15 nframes=1
pc=4338947807 func=30 file=31 line=18
Stack id=18 nframes=3
pc=4338696615 func=34 file=33 line=435
pc=4338494615 func=35 file=33 line=441
pc=4338494580 func=36 file=33 line=348
Stack id=20 nframes=4
pc=4338696615 func=34 file=33 line=435
pc=4338404715 func=35 file=33 line=441
pc=4338404688 func=37 file=38 line=425
pc=4338406051 func=39 file=38 line=653
Stack id=8 nframes=3
pc=4338307283 func=40 file=41 line=506
pc=4338629623 func=42 file=27 line=1023
pc=4338650327 func=43 file=44 line=54
Stack id=12 nframes=7
pc=4338842279 func=45 file=46 line=1709
pc=4338893599 func=47 file=48 line=211
pc=4338893584 func=49 file=50 line=745
pc=4338893200 func=51 file=50 line=381
pc=4338900535 func=52 file=53 line=46
pc=4338900528 func=54 file=55 line=195
pc=4338947031 func=56 file=29 line=134
Stack id=11 nframes=3
pc=4338307283 func=40 file=41 line=506
pc=4338629623 func=42 file=27 line=1023
pc=4338629287 func=57 file=27 line=960
Stack id=10 nframes=2
pc=4338946811 func=28 file=29 line=128
pc=4338947715 func=30 file=31 line=11
Stack id=19 nframes=3
pc=4338696615 func=34 file=33 line=435
pc=4338414175 func=35 file=33 line=441
pc=4338414140 func=58 file=59 line=276
Stack id=2 nframes=3
pc=4338624967 func=26 file=27 line=284
pc=4338946735 func=28 file=29 line=125
pc=4338947715 func=30 file=31 line=11
Stack id=6 nframes=1
pc=4338629235 func=57 file=27 line=957
Stack id=5 nframes=4
pc=4338650147 func=60 file=44 line=42
pc=4338625343 func=26 file=27 line=308
pc=4338946735 func=28 file=29 line=125
pc=4338947715 func=30 file=31 line=11
Stack id=14 nframes=3
pc=4338706919 func=61 file=62 line=338
pc=4338947823 func=63 file=31 line=31
pc=4338947808 func=30 file=31 line=19
Stack id=21 nframes=2
pc=4338696615 func=34 file=33 line=435
pc=4338361287 func=64 file=65 line=196
Stack id=4 nframes=1
pc=4338650259 func=43 file=44 line=42
Stack id=7 nframes=4
pc=4338629187 func=66 file=27 line=957
pc=4338625355 func=26 file=27 line=309
pc=4338946735 func=28 file=29 line=125
pc=4338947715 func=30 file=31 line=11
Stack id=9 nframes=1
pc=4338946963 func=56 file=29 line=128
Stack id=13 nframes=1
pc=4338947035 func=56 file=29 line=130
Stack id=16 nframes=1
pc=4338947839 func=30 file=31 line=17
Stack id=17 nframes=3
pc=4338885883 func=67 file=68 line=1341
pc=4338947935 func=69 file=31 line=24
pc=4338947807 func=30 file=31 line=18
EventBatch gen=1 m=18446744073709551615 time=5438516167110 size=2444
Strings
String id=1
data="Not worker"
String id=2
data="GC (dedicated)"
String id=3
data="GC (fractional)"
String id=4
data="GC (idle)"
String id=5
data="unspecified"
String id=6
data="forever"
String id=7
data="network"
String id=8
data="select"
String id=9
data="sync.(*Cond).Wait"
String id=10
data="sync"
String id=11
data="chan send"
String id=12
data="chan receive"
String id=13
data="GC mark assist wait for work"
String id=14
data="GC background sweeper wait"
String id=15
data="system goroutine wait"
String id=16
data="preempted"
String id=17
data="wait for debug call"
String id=18
data="wait until GC ends"
String id=19
data="sleep"
String id=20
data="GC weak to strong wait"
String id=21
data="synctest"
String id=22
data="runtime.Gosched"
String id=23
data="start trace"
String id=24
data="runtime.traceLocker.Gomaxprocs"
String id=25
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/traceruntime.go"
String id=26
data="runtime.StartTrace"
String id=27
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go"
String id=28
data="runtime/trace.Start"
String id=29
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go"
String id=30
data="main.main"
String id=31
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/cmd/trace/testdata/testprog2/main.go"
String id=32
data="runtime.startTheWorld"
String id=33
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go"
String id=34
data="runtime.gopark"
String id=35
data="runtime.goparkunlock"
String id=36
data="runtime.forcegchelper"
String id=37
data="runtime.(*scavengerState).park"
String id=38
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcscavenge.go"
String id=39
data="runtime.bgscavenge"
String id=40
data="runtime.chanrecv1"
String id=41
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go"
String id=42
data="runtime.(*wakeableSleep).sleep"
String id=43
data="runtime.traceStartReadCPU.func1"
String id=44
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go"
String id=45
data="syscall.write"
String id=46
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go"
String id=47
data="syscall.Write"
String id=48
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go"
String id=49
data="internal/poll.ignoringEINTRIO"
String id=50
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go"
String id=51
data="internal/poll.(*FD).Write"
String id=52
data="os.(*File).write"
String id=53
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go"
String id=54
data="os.(*File).Write"
String id=55
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go"
String id=56
data="runtime/trace.Start.func1"
String id=57
data="runtime.(*traceAdvancerState).start.func1"
String id=58
data="runtime.bgsweep"
String id=59
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcsweep.go"
String id=60
data="runtime.traceStartReadCPU"
String id=61
data="time.Sleep"
String id=62
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/time.go"
String id=63
data="main.offCPUSleep"
String id=64
data="runtime.runfinq"
String id=65
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mfinal.go"
String id=66
data="runtime.(*traceAdvancerState).start"
String id=67
data="time.Now"
String id=68
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/time/time.go"
String id=69
data="main.onCPULoop"
EventBatch gen=2 m=18446744073709551615 time=5438531846952 size=5
Frequency freq=15625000
EventBatch gen=2 m=6130872320 time=5438531846882 size=33
ProcStart dt=1 p=0 p_seq=9
GoStatus dt=6 g=1 m=18446744073709551615 gstatus=4
GoUnblock dt=2 g=1 g_seq=1 stack=0
GoStart dt=56 g=1 g_seq=2
HeapAlloc dt=63 heapalloc_value=2990080
EventBatch gen=2 m=6130298880 time=5438531804964 size=164
ProcStatus dt=63 p=0 pstatus=1
GoStatus dt=4 g=35 m=6130298880 gstatus=2
ProcsChange dt=92 procs_value=10 stack=1
HeapAlloc dt=448 heapalloc_value=2973696
HeapAlloc dt=1367 heapalloc_value=2981888
ProcStatus dt=991 p=1 pstatus=2
ProcStatus dt=11 p=2 pstatus=2
ProcStatus dt=10 p=3 pstatus=2
ProcStatus dt=8 p=4 pstatus=2
ProcStatus dt=10 p=5 pstatus=2
ProcStatus dt=9 p=6 pstatus=2
ProcStatus dt=9 p=7 pstatus=2
ProcStatus dt=9 p=8 pstatus=2
ProcStatus dt=10 p=9 pstatus=2
GoBlock dt=103 reason_string=10 stack=2
GoStatus dt=4 g=36 m=18446744073709551615 gstatus=4
GoUnblock dt=1 g=36 g_seq=1 stack=0
GoStart dt=20 g=36 g_seq=2
GoSyscallBegin dt=90 p_seq=1 stack=3
GoSyscallEnd dt=319
GoSyscallBegin dt=13 p_seq=2 stack=3
GoSyscallEnd dt=38
GoSyscallBegin dt=4 p_seq=3 stack=3
GoSyscallEnd dt=36
GoSyscallBegin dt=3 p_seq=4 stack=3
GoSyscallEnd dt=28
GoSyscallBegin dt=2 p_seq=5 stack=3
GoSyscallEnd dt=37
GoSyscallBegin dt=2 p_seq=6 stack=3
GoSyscallEnd dt=28
GoSyscallBegin dt=2 p_seq=7 stack=3
GoSyscallEnd dt=26
GoSyscallBegin dt=3 p_seq=8 stack=3
GoSyscallEnd dt=174
GoUnblock dt=7 g=35 g_seq=1 stack=4
GoBlock dt=24 reason_string=15 stack=5
GoStart dt=4 g=35 g_seq=2
GoBlock dt=22 reason_string=12 stack=6
ProcStop dt=8
EventBatch gen=2 m=8674447168 time=5438531808300 size=13
ProcStart dt=52 p=1 p_seq=1
ProcStop dt=12
ProcStart dt=626 p=1 p_seq=2
ProcStop dt=8
EventBatch gen=2 m=18446744073709551615 time=5438531847024 size=75
GoStatusStack dt=1 g=2 m=18446744073709551615 gstatus=4 stack=7
GoStatusStack dt=1 g=17 m=18446744073709551615 gstatus=4 stack=8
GoStatusStack dt=1 g=18 m=18446744073709551615 gstatus=4 stack=9
GoStatusStack dt=1 g=33 m=18446744073709551615 gstatus=4 stack=10
GoStatusStack dt=1 g=34 m=18446744073709551615 gstatus=4 stack=11
EventBatch gen=2 m=18446744073709551615 time=5438531847080 size=333
Stacks
Stack id=1 nframes=3
pc=4338656324 func=23 file=24 line=286
pc=4338707527 func=25 file=26 line=452
pc=4338629295 func=27 file=26 line=963
Stack id=7 nframes=3
pc=4338696615 func=28 file=29 line=435
pc=4338494615 func=30 file=29 line=441
pc=4338494580 func=31 file=29 line=348
Stack id=9 nframes=4
pc=4338696615 func=28 file=29 line=435
pc=4338404715 func=30 file=29 line=441
pc=4338404688 func=32 file=33 line=425
pc=4338406051 func=34 file=33 line=653
Stack id=3 nframes=7
pc=4338842279 func=35 file=36 line=1709
pc=4338893599 func=37 file=38 line=211
pc=4338893584 func=39 file=40 line=745
pc=4338893200 func=41 file=40 line=381
pc=4338900535 func=42 file=43 line=46
pc=4338900528 func=44 file=45 line=195
pc=4338947031 func=46 file=47 line=134
Stack id=6 nframes=3
pc=4338307283 func=48 file=49 line=506
pc=4338629623 func=50 file=26 line=1023
pc=4338629287 func=27 file=26 line=960
Stack id=8 nframes=3
pc=4338696615 func=28 file=29 line=435
pc=4338414175 func=30 file=29 line=441
pc=4338414140 func=51 file=52 line=276
Stack id=2 nframes=2
pc=4338709092 func=25 file=26 line=650
pc=4338629295 func=27 file=26 line=963
Stack id=4 nframes=1
pc=0 func=0 file=0 line=0
Stack id=10 nframes=2
pc=4338696615 func=28 file=29 line=435
pc=4338361287 func=53 file=54 line=196
Stack id=5 nframes=1
pc=4338947035 func=46 file=47 line=130
Stack id=11 nframes=5
pc=4338696615 func=28 file=29 line=435
pc=4338308363 func=55 file=49 line=664
pc=4338307283 func=48 file=49 line=506
pc=4338629623 func=50 file=26 line=1023
pc=4338650327 func=56 file=57 line=54
EventBatch gen=2 m=18446744073709551615 time=5438531804875 size=2018
Strings
String id=1
data="Not worker"
String id=2
data="GC (dedicated)"
String id=3
data="GC (fractional)"
String id=4
data="GC (idle)"
String id=5
data="unspecified"
String id=6
data="forever"
String id=7
data="network"
String id=8
data="select"
String id=9
data="sync.(*Cond).Wait"
String id=10
data="sync"
String id=11
data="chan send"
String id=12
data="chan receive"
String id=13
data="GC mark assist wait for work"
String id=14
data="GC background sweeper wait"
String id=15
data="system goroutine wait"
String id=16
data="preempted"
String id=17
data="wait for debug call"
String id=18
data="wait until GC ends"
String id=19
data="sleep"
String id=20
data="GC weak to strong wait"
String id=21
data="synctest"
String id=22
data="runtime.Gosched"
String id=23
data="runtime.traceLocker.Gomaxprocs"
String id=24
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/traceruntime.go"
String id=25
data="runtime.traceAdvance"
String id=26
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace.go"
String id=27
data="runtime.(*traceAdvancerState).start.func1"
String id=28
data="runtime.gopark"
String id=29
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/proc.go"
String id=30
data="runtime.goparkunlock"
String id=31
data="runtime.forcegchelper"
String id=32
data="runtime.(*scavengerState).park"
String id=33
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcscavenge.go"
String id=34
data="runtime.bgscavenge"
String id=35
data="syscall.write"
String id=36
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/zsyscall_darwin_arm64.go"
String id=37
data="syscall.Write"
String id=38
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/syscall/syscall_unix.go"
String id=39
data="internal/poll.ignoringEINTRIO"
String id=40
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/internal/poll/fd_unix.go"
String id=41
data="internal/poll.(*FD).Write"
String id=42
data="os.(*File).write"
String id=43
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file_posix.go"
String id=44
data="os.(*File).Write"
String id=45
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/os/file.go"
String id=46
data="runtime/trace.Start.func1"
String id=47
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/trace/trace.go"
String id=48
data="runtime.chanrecv1"
String id=49
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/chan.go"
String id=50
data="runtime.(*wakeableSleep).sleep"
String id=51
data="runtime.bgsweep"
String id=52
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mgcsweep.go"
String id=53
data="runtime.runfinq"
String id=54
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/mfinal.go"
String id=55
data="runtime.chanrecv"
String id=56
data="runtime.traceStartReadCPU.func1"
String id=57
data="/Users/felix.geisendoerfer/go/src/github.com/golang/go/src/runtime/tracecpu.go"
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment