DST: 4251 #1038
Description
DST Failed
DST run failed for seed=4251, ticks=1000, scenario=default, store=sqlite.
Seed
4251
Scenario
default
Store
sqlite
Commit
5514db3b6a3a0334fb74c30c5fba44f7af6dcee8
Command
go run ./... dst run --seed 4251 --ticks 1000 --scenario default --aio-store-sqlite-enable
Logs
level=INFO msg=DST seed=4251 ticks=1000 reqsPerTick=1:25 dst="DST(ids=21, headers=11, data=19, tags=9, backchannel=381)" system="System(api=API(size=504, subsystems=[]), aio=AIODST(subsystems=[router sender store]), config=Config(cms=419, sbs=248, cbs=586, pbs=19, sbs=93, tbs=30))"
level=INFO msg=DST id=0 t=0|999 req="PromiseRegister(awaiter=p02, awaited=p11)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=1 t=0|999 req="PromiseRegister(awaiter=p02, awaited=p13)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=3 t=1000|1999 req="ScheduleDelete(id=s20)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=4 t=1000|1999 req="CallbackCreate(id=__resume:p05:p19, promiseId=p19, recv=\"dst\", mesg=Mesg(type=resume, root=p05, leaf=p19), timeout=792901)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=7 t=1000|1999 req="PromiseComplete(id=p16, state=REJECTED_CANCELED, value=Value(headers=map[], data=18))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=8 t=1000|1999 req="PromiseComplete(id=p05, state=REJECTED_CANCELED, value=Value(headers=map[], data=))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=9 t=1000|1999 req="CallbackCreate(id=__notify:p10:cb01, promiseId=p10, recv=\"dst\", mesg=Mesg(type=notify, root=p10, leaf=), timeout=953218)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=13 t=1000|1999 req="ScheduleDelete(id=s09)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=15 t=1000|1999 req="PromiseComplete(id=p20, state=RESOLVED, value=Value(headers=map[], data=17))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=19 t=1000|1999 req="CallbackCreate(id=__resume:p18:p02, promiseId=p02, recv=\"dst\", mesg=Mesg(type=resume, root=p18, leaf=p02), timeout=978491)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=21 t=1000|1999 req="PromiseComplete(id=p14, state=REJECTED_CANCELED, value=Value(headers=map[], data=4))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=23 t=1000|1999 req="ScheduleDelete(id=s09)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=24 t=1000|1999 req="ScheduleDelete(id=s05)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=25 t=1000|1999 req="CallbackCreate(id=__resume:p01:p12, promiseId=p12, recv=\"dst\", mesg=Mesg(type=resume, root=p01, leaf=p12), timeout=192938)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=2 t=0|1999 req="ScheduleCreate(id=s18, desc=, cron=3 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s18.{{.timestamp}}, promiseTimeout=397697, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s18, desc=, cron=3 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s18.{{.timestamp}}, promiseTimeout=397697, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=180000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=5 t=1000|1999 req="PromiseRegister(awaiter=p06, awaited=p17)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=6 t=1000|1999 req="PromiseSubscribe(awaited=p01, address=addr04)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=14 t=1000|1999 req="PromiseSubscribe(awaited=p16, address=addr08)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=16 t=1000|1999 req="PromiseRegister(awaiter=p13, awaited=p04)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=20 t=1000|1999 req="PromiseSubscribe(awaited=p11, address=addr11)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=22 t=1000|1999 req="PromiseGet(id=p12)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=28 t=2000|2999 req="PromiseComplete(id=p18, state=REJECTED_CANCELED, value=Value(headers=map[], data=9))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=30 t=2000|2999 req="ScheduleDelete(id=s08)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=31 t=2000|2999 req="CallbackCreate(id=__resume:p15:p06, promiseId=p06, recv=\"dst\", mesg=Mesg(type=resume, root=p15, leaf=p06), timeout=283237)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=33 t=2000|2999 req="ScheduleGet(id=s03)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=35 t=2000|2999 req="ScheduleDelete(id=s14)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=18 t=1000|2999 req="ScheduleCreate(id=s14, desc=, cron=51 * * * *, tags=map[0:0.0 resonate:invoke:dst], promiseId=s14.{{.timestamp}}, promiseTimeout=263248, promiseParam=Value(headers=map[0:6.0], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s14, desc=, cron=51 * * * *, tags=map[0:0.0 resonate:invoke:dst], promiseId=s14.{{.timestamp}}, promiseTimeout=263248, promiseParam=Value(headers=map[0:6.0], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3060000, createdOn=2000)))" err=<nil>
level=INFO msg=DST id=27 t=2000|2999 req="PromiseSubscribe(awaited=p00, address=addr18)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=29 t=2000|2999 req="PromiseGet(id=p11)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=32 t=2000|2999 req="PromiseRegister(awaiter=p20, awaited=p08)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=34 t=2000|2999 req="PromiseRegister(awaiter=p05, awaited=p06)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=37 t=3000|3999 req="ScheduleGet(id=s06)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=38 t=3000|3999 req="CallbackCreate(id=__resume:p16:p17, promiseId=p17, recv=\"dst\", mesg=Mesg(type=resume, root=p16, leaf=p17), timeout=378242)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=46 t=3000|3999 req="ScheduleGet(id=s05)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=51 t=3000|3999 req="ScheduleGet(id=s00)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=57 t=3000|3999 req="ScheduleDelete(id=s10)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=10 t=1000|3999 req="TaskCreate(promise=PromiseCreate(id=p09, param=Value(headers=map[], data=13), timeout=23870, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p09, processId=p09, ttl=4000, timeout=23870))" res="Response(status=20100, TaskCreate(promise=Promise(id=p09, state=PENDING, param=Value(headers=map[], data=13), value=Value(headers=map[], data=), timeout=23870, tags=map[resonate:invoke:dst], createdOn=1000, completedOn=0), task=Task(id=__invoke:p09, processId=p09, state=CLAIMED, rootPromiseId=p09, recv=\"dst\", mesg=Mesg(type=invoke, root=p09, leaf=p09), timeout=23870, counter=1, attempt=0, ttl=4000, expiresAt=5000, createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=11 t=1000|3999 req="TaskCreate(promise=PromiseCreate(id=p04, param=Value(headers=map[], data=), timeout=96209, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p04, processId=p04, ttl=9223372036854775807, timeout=96209))" res="Response(status=20100, TaskCreate(promise=Promise(id=p04, state=PENDING, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=96209, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=0), task=Task(id=__invoke:p04, processId=p04, state=CLAIMED, rootPromiseId=p04, recv=\"dst\", mesg=Mesg(type=invoke, root=p04, leaf=p04), timeout=96209, counter=1, attempt=0, ttl=9223372036854775807, expiresAt=9223372036854775807, createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=12 t=1000|3999 req="PromiseCreate(id=p01, param=Value(headers=map[0:2.0], data=), timeout=422358, tags=map[])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p01, state=PENDING, param=Value(headers=map[0:2.0], data=), value=Value(headers=map[], data=), timeout=422358, tags=map[], createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=17 t=1000|3999 req="PromiseCreate(id=p13, param=Value(headers=map[], data=), timeout=750506, tags=map[0:0.0 resonate:invoke:dst])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p13, state=PENDING, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=750506, tags=map[0:0.0 resonate:invoke:dst], createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=26 t=1000|3999 req="PromiseCreate(id=p08, param=Value(headers=map[], data=12), timeout=297584, tags=map[])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p08, state=PENDING, param=Value(headers=map[], data=12), value=Value(headers=map[], data=), timeout=297584, tags=map[], createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=39 t=3000|3999 req="PromiseSubscribe(awaited=p00, address=addr06)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=41 t=3000|3999 req="PromiseGet(id=p01)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=44 t=3000|3999 req="PromiseRegister(awaiter=p07, awaited=p09)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=47 t=3000|3999 req="PromiseSubscribe(awaited=p02, address=addr01)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=49 t=3000|3999 req="PromiseSubscribe(awaited=p19, address=addr17)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=50 t=3000|3999 req="PromiseGet(id=p05)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=53 t=3000|3999 req="PromiseCreate(id=p01, param=Value(headers=map[0:5.0 1:5.1], data=18), timeout=451655, tags=map[0:8.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p01, state=PENDING, param=Value(headers=map[0:2.0], data=), value=Value(headers=map[], data=), timeout=422358, tags=map[], createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=54 t=3000|3999 req="PromiseGet(id=p09)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
...
level=INFO msg=DST id=12281 t=991000|992999 req="ScheduleCreate(id=s17, desc=, cron=54 * * * *, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], promiseId=s17.{{.timestamp}}, promiseTimeout=996195, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s17, desc=, cron=54 * * * *, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], promiseId=s17.{{.timestamp}}, promiseTimeout=996195, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3240000, createdOn=992000)))" err=<nil>
level=INFO msg=DST id=12286 t=991000|992999 req="ScheduleCreate(id=s03, desc=, cron=53 * * * *, tags=map[], promiseId=s03.{{.timestamp}}, promiseTimeout=993018, promiseParam=Value(headers=map[], data=7), promiseTags=map[0:2.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s03, desc=, cron=53 * * * *, tags=map[], promiseId=s03.{{.timestamp}}, promiseTimeout=993018, promiseParam=Value(headers=map[], data=7), promiseTags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=3180000, createdOn=992000)))" err=<nil>
level=INFO msg=DST id=12288 t=992000|992999 req="TaskCreate(promise=PromiseCreate(id=p09, param=Value(headers=map[], data=12), timeout=686646, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p09, processId=p09, ttl=5000, timeout=686646))" res="Response(status=20000, TaskCreate(promise=Promise(id=p09, state=REJECTED_TIMEDOUT, param=Value(headers=map[], data=13), value=Value(headers=map[], data=), timeout=23870, tags=map[resonate:invoke:dst], createdOn=1000, completedOn=23870), task=<nil>))" err=<nil>
level=INFO msg=DST id=12290 t=992000|992999 req="PromiseCreate(id=p17, param=Value(headers=map[], data=), timeout=243710, tags=map[resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:4.0 1:4.1], data=18), timeout=68868, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=19000)))" err=<nil>
level=INFO msg=DST id=12292 t=992000|992999 req="TaskCreate(promise=PromiseCreate(id=p01, param=Value(headers=map[0:4.0 1:4.1], data=), timeout=756176, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p01, processId=p01, ttl=5000, timeout=756176))" res="Response(status=20000, TaskCreate(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[0:2.0], data=), value=Value(headers=map[0:6.0], data=2), timeout=422358, tags=map[], createdOn=1000, completedOn=20000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12293 t=992000|992999 req="PromiseSubscribe(awaited=p12, address=addr14)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=11), timeout=753057, tags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], createdOn=23000, completedOn=38000)))" err=<nil>
level=INFO msg=DST id=12294 t=992000|992999 req="PromiseSubscribe(awaited=p01, address=addr10)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[0:2.0], data=), value=Value(headers=map[0:6.0], data=2), timeout=422358, tags=map[], createdOn=1000, completedOn=20000)))" err=<nil>
level=INFO msg=DST id=12298 t=992000|992999 req="PromiseGet(id=p03)" res="Response(status=20000, PromiseGet(promise=Promise(id=p03, state=RESOLVED, param=Value(headers=map[0:4.0 1:4.1], data=), value=Value(headers=map[0:3.0 1:3.1], data=2), timeout=948291, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=5000, completedOn=48000)))" err=<nil>
level=INFO msg=DST id=12299 t=992000|992999 req="PromiseGet(id=p07)" res="Response(status=20000, PromiseGet(promise=Promise(id=p07, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=2), value=Value(headers=map[0:9.0], data=16), timeout=715212, tags=map[resonate:invoke:dst], createdOn=13000, completedOn=52000)))" err=<nil>
level=INFO msg=DST id=12300 t=992000|992999 req="PromiseCreate(id=p06, param=Value(headers=map[], data=), timeout=959501, tags=map[0:8.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=6), value=Value(headers=map[], data=17), timeout=93588, tags=map[resonate:invoke:dst], createdOn=5000, completedOn=65000)))" err=<nil>
level=INFO msg=DST id=12304 t=992000|992999 req="PromiseSubscribe(awaited=p11, address=addr04)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12306 t=992000|992999 req="PromiseRegister(awaiter=p02, awaited=p11)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12307 t=992000|992999 req="PromiseCreate(id=p11, param=Value(headers=map[], data=), timeout=405516, tags=map[0:1.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12309 t=992000|992999 req="PromiseSubscribe(awaited=p04, address=addr17)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p04, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=15), timeout=96209, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=6000)))" err=<nil>
level=INFO msg=DST id=12312 t=993000|993999 req="PromiseComplete(id=p09, state=REJECTED_CANCELED, value=Value(headers=map[], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p09, state=REJECTED_TIMEDOUT, param=Value(headers=map[], data=13), value=Value(headers=map[], data=), timeout=23870, tags=map[resonate:invoke:dst], createdOn=1000, completedOn=23870)))" err=<nil>
level=INFO msg=DST id=12313 t=993000|993999 req="CallbackCreate(id=__resume:p07:p10, promiseId=p10, recv=\"dst\", mesg=Mesg(type=resume, root=p07, leaf=p10), timeout=995570)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[], data=14), value=Value(headers=map[0:10.0 1:10.1], data=5), timeout=95004, tags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], createdOn=19000, completedOn=39000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12315 t=993000|993999 req="PromiseComplete(id=p04, state=REJECTED, value=Value(headers=map[], data=1))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p04, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=15), timeout=96209, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=6000)))" err=<nil>
level=INFO msg=DST id=12317 t=993000|993999 req="PromiseComplete(id=p15, state=REJECTED, value=Value(headers=map[], data=7))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p15, state=REJECTED, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=2), value=Value(headers=map[], data=10), timeout=218079, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], createdOn=3000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12318 t=993000|993999 req="ScheduleGet(id=s17)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s17, desc=, cron=54 * * * *, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], promiseId=s17.{{.timestamp}}, promiseTimeout=996195, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3240000, createdOn=992000)))" err=<nil>
level=INFO msg=DST id=12321 t=993000|993999 req="ScheduleGet(id=s06)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12322 t=993000|993999 req="PromiseComplete(id=p10, state=REJECTED_CANCELED, value=Value(headers=map[0:9.0], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[], data=14), value=Value(headers=map[0:10.0 1:10.1], data=5), timeout=95004, tags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], createdOn=19000, completedOn=39000)))" err=<nil>
level=INFO msg=DST id=12323 t=993000|993999 req="PromiseComplete(id=p02, state=RESOLVED, value=Value(headers=map[], data=1))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=17), value=Value(headers=map[], data=), timeout=602033, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=11000, completedOn=72000)))" err=<nil>
level=INFO msg=DST id=12325 t=993000|993999 req="PromiseComplete(id=p08, state=REJECTED_CANCELED, value=Value(headers=map[], data=2))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p08, state=RESOLVED, param=Value(headers=map[], data=12), value=Value(headers=map[], data=), timeout=297584, tags=map[], createdOn=1000, completedOn=46000)))" err=<nil>
level=INFO msg=DST id=12295 t=992000|993999 req="ScheduleCreate(id=s00, desc=, cron=54 * * * *, tags=map[], promiseId=s00.{{.timestamp}}, promiseTimeout=992260, promiseParam=Value(headers=map[0:4.0 1:4.1], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s00, desc=, cron=54 * * * *, tags=map[], promiseId=s00.{{.timestamp}}, promiseTimeout=992260, promiseParam=Value(headers=map[0:4.0 1:4.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3240000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12305 t=992000|993999 req="ScheduleCreate(id=s06, desc=, cron=47 * * * *, tags=map[], promiseId=s06.{{.timestamp}}, promiseTimeout=998195, promiseParam=Value(headers=map[], data=), promiseTags=map[0:3.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s06, desc=, cron=47 * * * *, tags=map[], promiseId=s06.{{.timestamp}}, promiseTimeout=998195, promiseParam=Value(headers=map[], data=), promiseTags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=2820000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12310 t=993000|993999 req="PromiseCreate(id=p15, param=Value(headers=map[0:4.0 1:4.1], data=6), timeout=439290, tags=map[0:1.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p15, state=REJECTED, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=2), value=Value(headers=map[], data=10), timeout=218079, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], createdOn=3000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12311 t=993000|993999 req="PromiseGet(id=p00)" res="Response(status=20000, PromiseGet(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:10.0 1:10.1], data=), value=Value(headers=map[], data=12), timeout=946521, tags=map[resonate:timeout:true], createdOn=2000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12314 t=993000|993999 req="PromiseGet(id=p15)" res="Response(status=20000, PromiseGet(promise=Promise(id=p15, state=REJECTED, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=2), value=Value(headers=map[], data=10), timeout=218079, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], createdOn=3000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12316 t=993000|993999 req="PromiseGet(id=p11)" res="Response(status=20000, PromiseGet(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12319 t=993000|993999 req="TaskCreate(promise=PromiseCreate(id=p07, param=Value(headers=map[], data=), timeout=129953, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p07, processId=p07, ttl=9223372036854775807, timeout=129953))" res="Response(status=20000, TaskCreate(promise=Promise(id=p07, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=2), value=Value(headers=map[0:9.0], data=16), timeout=715212, tags=map[resonate:invoke:dst], createdOn=13000, completedOn=52000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12324 t=993000|993999 req="PromiseCreate(id=p11, param=Value(headers=map[], data=18), timeout=520716, tags=map[resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12326 t=993000|993999 req="TaskCreate(promise=PromiseCreate(id=p17, param=Value(headers=map[], data=), timeout=752227, tags=map[resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p17, processId=p17, ttl=1000, timeout=752227))" res="Response(status=20000, TaskCreate(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:4.0 1:4.1], data=18), timeout=68868, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=19000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12329 t=994000|994999 req="ScheduleDelete(id=s01)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12330 t=994000|994999 req="PromiseComplete(id=p16, state=REJECTED_CANCELED, value=Value(headers=map[0:7.0 1:7.1 2:7.2], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p16, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:9.0], data=3), timeout=170796, tags=map[], createdOn=4000, completedOn=31000)))" err=<nil>
level=INFO msg=DST id=12331 t=994000|994999 req="ScheduleGet(id=s04)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s04, desc=, cron=55 * * * *, tags=map[0:8.0 resonate:invoke:dst resonate:timeout:true], promiseId=s04.{{.timestamp}}, promiseTimeout=959321, promiseParam=Value(headers=map[], data=9), promiseTags=map[], lastRunTime=0, nextRunTime=3300000, createdOn=960000)))" err=<nil>
level=INFO msg=DST id=12332 t=994000|994999 req="PromiseComplete(id=p14, state=REJECTED_CANCELED, value=Value(headers=map[0:9.0], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p14, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:4.0 1:4.1], data=), timeout=153228, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=10000, completedOn=47000)))" err=<nil>
level=INFO msg=DST id=12320 t=993000|994999 req="ScheduleCreate(id=s02, desc=, cron=59 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s02.{{.timestamp}}, promiseTimeout=998962, promiseParam=Value(headers=map[0:5.0 1:5.1], data=18), promiseTags=map[0:1.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s02, desc=, cron=59 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s02.{{.timestamp}}, promiseTimeout=998962, promiseParam=Value(headers=map[0:5.0 1:5.1], data=18), promiseTags=map[0:1.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=3540000, createdOn=994000)))" err=<nil>
level=INFO msg=DST id=12327 t=994000|994999 req="PromiseGet(id=p06)" res="Response(status=20000, PromiseGet(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=6), value=Value(headers=map[], data=17), timeout=93588, tags=map[resonate:invoke:dst], createdOn=5000, completedOn=65000)))" err=<nil>
level=INFO msg=DST id=12328 t=994000|994999 req="PromiseRegister(awaiter=p09, awaited=p08)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p08, state=RESOLVED, param=Value(headers=map[], data=12), value=Value(headers=map[], data=), timeout=297584, tags=map[], createdOn=1000, completedOn=46000)))" err=<nil>
level=INFO msg=DST id=12335 t=995000|995999 req="CallbackCreate(id=__resume:p02:p16, promiseId=p16, recv=\"dst\", mesg=Mesg(type=resume, root=p02, leaf=p16), timeout=995910)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p16, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:9.0], data=3), timeout=170796, tags=map[], createdOn=4000, completedOn=31000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12337 t=995000|995999 req="ScheduleGet(id=s13)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12338 t=995000|995999 req="CallbackCreate(id=__resume:p14:p02, promiseId=p02, recv=\"dst\", mesg=Mesg(type=resume, root=p14, leaf=p02), timeout=995783)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=17), value=Value(headers=map[], data=), timeout=602033, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=11000, completedOn=72000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12339 t=995000|995999 req="CallbackCreate(id=__notify:p07:cb02, promiseId=p07, recv=\"dst\", mesg=Mesg(type=notify, root=p07, leaf=), timeout=997512)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p07, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=2), value=Value(headers=map[0:9.0], data=16), timeout=715212, tags=map[resonate:invoke:dst], createdOn=13000, completedOn=52000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12341 t=995000|995999 req="CallbackCreate(id=__resume:p02:p05, promiseId=p05, recv=\"dst\", mesg=Mesg(type=resume, root=p02, leaf=p05), timeout=997660)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p05, state=RESOLVED, param=Value(headers=map[], data=18), value=Value(headers=map[], data=7), timeout=827474, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=37000, completedOn=45000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12333 t=995000|995999 req="PromiseRegister(awaiter=p01, awaited=p12)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12334 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p04, param=Value(headers=map[], data=), timeout=193269, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p04, processId=p04, ttl=3000, timeout=193269))" res="Response(status=20000, TaskCreate(promise=Promise(id=p04, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=15), timeout=96209, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=6000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12336 t=995000|995999 req="PromiseCreate(id=p19, param=Value(headers=map[0:10.0 1:10.1], data=11), timeout=250539, tags=map[0:8.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p19, state=RESOLVED, param=Value(headers=map[0:5.0 1:5.1], data=), value=Value(headers=map[0:7.0 1:7.1 2:7.2], data=12), timeout=319294, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=14000)))" err=<nil>
level=INFO msg=DST id=12340 t=995000|995999 req="PromiseSubscribe(awaited=p13, address=addr14)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p13, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=3), timeout=750506, tags=map[0:0.0 resonate:invoke:dst], createdOn=1000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12342 t=995000|995999 req="PromiseSubscribe(awaited=p20, address=addr09)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p20, state=RESOLVED, param=Value(headers=map[], data=15), value=Value(headers=map[0:5.0 1:5.1], data=), timeout=878530, tags=map[resonate:invoke:dst], createdOn=3000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12344 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p01, param=Value(headers=map[0:6.0], data=), timeout=745159, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p01, processId=p01, ttl=9223372036854775807, timeout=745159))" res="Response(status=20000, TaskCreate(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[0:2.0], data=), value=Value(headers=map[0:6.0], data=2), timeout=422358, tags=map[], createdOn=1000, completedOn=20000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12345 t=995000|995999 req="PromiseRegister(awaiter=p14, awaited=p17)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:4.0 1:4.1], data=18), timeout=68868, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=19000)))" err=<nil>
level=INFO msg=DST id=12346 t=996000|996999 req="CallbackCreate(id=__resume:p11:p20, promiseId=p20, recv=\"dst\", mesg=Mesg(type=resume, root=p11, leaf=p20), timeout=998274)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p20, state=RESOLVED, param=Value(headers=map[], data=15), value=Value(headers=map[0:5.0 1:5.1], data=), timeout=878530, tags=map[resonate:invoke:dst], createdOn=3000, completedOn=25000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12343 t=995000|996999 req="ScheduleCreate(id=s12, desc=, cron=28 * * * *, tags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], promiseId=s12.{{.timestamp}}, promiseTimeout=997212, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s12, desc=, cron=28 * * * *, tags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], promiseId=s12.{{.timestamp}}, promiseTimeout=997212, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=1680000, createdOn=996000)))" err=<nil>
level=INFO msg=DST id=12347 t=996000|996999 req="PromiseCreate(id=p13, param=Value(headers=map[], data=), timeout=306396, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p13, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=3), timeout=750506, tags=map[0:0.0 resonate:invoke:dst], createdOn=1000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12348 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p02, param=Value(headers=map[], data=7), timeout=359533, tags=map[resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p02, processId=p02, ttl=9223372036854775807, timeout=359533))" res="Response(status=20000, TaskCreate(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=17), value=Value(headers=map[], data=), timeout=602033, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=11000, completedOn=72000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12349 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p11, param=Value(headers=map[], data=13), timeout=661786, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p11, processId=p11, ttl=9223372036854775807, timeout=661786))" res="Response(status=20000, TaskCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12350 t=997000|997999 req="ScheduleCreate(id=s10, desc=, cron=43 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=999161, promiseParam=Value(headers=map[0:7.0 1:7.1 2:7.2], data=), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s10, desc=, cron=11 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=988404, promiseParam=Value(headers=map[0:5.0 1:5.1], data=), promiseTags=map[0:0.0 resonate:invoke:dst], lastRunTime=0, nextRunTime=4260000, createdOn=978000)))" err=<nil>
level=INFO msg=DST id=12353 t=997000|997999 req="ScheduleDelete(id=s06)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12354 t=997000|997999 req="ScheduleGet(id=s19)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12356 t=997000|997999 req="CallbackCreate(id=__notify:p06:cb15, promiseId=p06, recv=\"dst\", mesg=Mesg(type=notify, root=p06, leaf=), timeout=999702)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=6), value=Value(headers=map[], data=17), timeout=93588, tags=map[resonate:invoke:dst], createdOn=5000, completedOn=65000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12358 t=997000|997999 req="ScheduleCreate(id=s06, desc=, cron=24 * * * *, tags=map[], promiseId=s06.{{.timestamp}}, promiseTimeout=999680, promiseParam=Value(headers=map[0:3.0 1:3.1], data=), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s06, desc=, cron=47 * * * *, tags=map[], promiseId=s06.{{.timestamp}}, promiseTimeout=998195, promiseParam=Value(headers=map[], data=), promiseTags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=2820000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12364 t=997000|997999 req="ScheduleGet(id=s11)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s11, desc=, cron=13 * * * *, tags=map[], promiseId=s11.{{.timestamp}}, promiseTimeout=992519, promiseParam=Value(headers=map[0:5.0 1:5.1], data=11), promiseTags=map[0:8.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=4380000, createdOn=986000)))" err=<nil>
level=INFO msg=DST id=12366 t=997000|997999 req="ScheduleDelete(id=s10)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12352 t=997000|997999 req="PromiseRegister(awaiter=p10, awaited=p06)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=6), value=Value(headers=map[], data=17), timeout=93588, tags=map[resonate:invoke:dst], createdOn=5000, completedOn=65000)))" err=<nil>
level=INFO msg=DST id=12357 t=997000|997999 req="PromiseCreate(id=p18, param=Value(headers=map[0:4.0 1:4.1], data=), timeout=798571, tags=map[0:0.0 resonate:invoke:dst])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p18, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:0.0 1:0.1], data=6), timeout=815128, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=14000)))" err=<nil>
level=INFO msg=DST id=12359 t=997000|997999 req="TaskCreate(promise=PromiseCreate(id=p18, param=Value(headers=map[], data=13), timeout=280945, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p18, processId=p18, ttl=9223372036854775807, timeout=280945))" res="Response(status=20000, TaskCreate(promise=Promise(id=p18, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:0.0 1:0.1], data=6), timeout=815128, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=14000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12360 t=997000|997999 req="PromiseCreate(id=p15, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=6), timeout=114663, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p15, state=REJECTED, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=2), value=Value(headers=map[], data=10), timeout=218079, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], createdOn=3000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12362 t=997000|997999 req="PromiseRegister(awaiter=p05, awaited=p11)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:0.0 1:0.1], data=6), value=Value(headers=map[], data=2), timeout=112914, tags=map[], createdOn=23000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12363 t=997000|997999 req="PromiseSubscribe(awaited=p05, address=addr07)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p05, state=RESOLVED, param=Value(headers=map[], data=18), value=Value(headers=map[], data=7), timeout=827474, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=37000, completedOn=45000)))" err=<nil>
level=INFO msg=DST id=12365 t=997000|997999 req="PromiseRegister(awaiter=p00, awaited=p06)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12367 t=998000|998999 req="ScheduleDelete(id=s20)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12370 t=998000|998999 req="CallbackCreate(id=__resume:p04:p15, promiseId=p15, recv=\"dst\", mesg=Mesg(type=resume, root=p04, leaf=p15), timeout=998709)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p15, state=REJECTED, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=2), value=Value(headers=map[], data=10), timeout=218079, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], createdOn=3000, completedOn=8000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12371 t=998000|998999 req="PromiseComplete(id=p00, state=REJECTED_CANCELED, value=Value(headers=map[], data=9))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:10.0 1:10.1], data=), value=Value(headers=map[], data=12), timeout=946521, tags=map[resonate:timeout:true], createdOn=2000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12373 t=998000|998999 req="ScheduleGet(id=s12)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s12, desc=, cron=28 * * * *, tags=map[0:3.0 resonate:invoke:dst resonate:timeout:true], promiseId=s12.{{.timestamp}}, promiseTimeout=997212, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=1680000, createdOn=996000)))" err=<nil>
level=INFO msg=DST id=12374 t=998000|998999 req="ScheduleCreate(id=s05, desc=, cron=47 * * * *, tags=map[], promiseId=s05.{{.timestamp}}, promiseTimeout=998654, promiseParam=Value(headers=map[0:8.0 1:8.1 2:8.2], data=11), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s05, desc=, cron=48 * * * *, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], promiseId=s05.{{.timestamp}}, promiseTimeout=987372, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2880000, createdOn=980000)))" err=<nil>
level=INFO msg=DST id=12378 t=998000|998999 req="ScheduleDelete(id=s10)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12380 t=998000|998999 req="CallbackCreate(id=__notify:p18:cb09, promiseId=p18, recv=\"dst\", mesg=Mesg(type=notify, root=p18, leaf=), timeout=998858)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p18, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:0.0 1:0.1], data=6), timeout=815128, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=14000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12381 t=998000|998999 req="ScheduleDelete(id=s20)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12351 t=997000|998999 req="ScheduleCreate(id=s06, desc=, cron=0 * * * *, tags=map[0:1.0 resonate:invoke:dst resonate:timeout:true], promiseId=s06.{{.timestamp}}, promiseTimeout=998414, promiseParam=Value(headers=map[0:6.0], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s06, desc=, cron=0 * * * *, tags=map[0:1.0 resonate:invoke:dst resonate:timeout:true], promiseId=s06.{{.timestamp}}, promiseTimeout=998414, promiseParam=Value(headers=map[0:6.0], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=3600000, createdOn=998000)))" err=<nil>
level=INFO msg=DST id=12355 t=997000|998999 req="ScheduleCreate(id=s13, desc=, cron=45 * * * *, tags=map[0:0.0 resonate:invoke:dst], promiseId=s13.{{.timestamp}}, promiseTimeout=997347, promiseParam=Value(headers=map[], data=5), promiseTags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s13, desc=, cron=45 * * * *, tags=map[0:0.0 resonate:invoke:dst], promiseId=s13.{{.timestamp}}, promiseTimeout=997347, promiseParam=Value(headers=map[], data=5), promiseTags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=2700000, createdOn=998000)))" err=<nil>
level=INFO msg=DST id=12361 t=997000|998999 req="ScheduleCreate(id=s10, desc=, cron=25 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=997798, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s10, desc=, cron=25 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=997798, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=1500000, createdOn=998000)))" err=<nil>
level=INFO msg=DST id=12368 t=998000|998999 req="PromiseCreate(id=p13, param=Value(headers=map[], data=), timeout=471940, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p13, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=3), timeout=750506, tags=map[0:0.0 resonate:invoke:dst], createdOn=1000, completedOn=75000)))" err=<nil>
level=INFO msg=DST id=12369 t=998000|998999 req="PromiseGet(id=p00)" res="Response(status=20000, PromiseGet(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:10.0 1:10.1], data=), value=Value(headers=map[], data=12), timeout=946521, tags=map[resonate:timeout:true], createdOn=2000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12372 t=998000|998999 req="TaskCreate(promise=PromiseCreate(id=p05, param=Value(headers=map[], data=10), timeout=665570, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p05, processId=p05, ttl=1000, timeout=665570))" res="Response(status=20000, TaskCreate(promise=Promise(id=p05, state=RESOLVED, param=Value(headers=map[], data=18), value=Value(headers=map[], data=7), timeout=827474, tags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true], createdOn=37000, completedOn=45000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12376 t=998000|998999 req="PromiseSubscribe(awaited=p00, address=addr03)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:10.0 1:10.1], data=), value=Value(headers=map[], data=12), timeout=946521, tags=map[resonate:timeout:true], createdOn=2000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12377 t=998000|998999 req="PromiseGet(id=p16)" res="Response(status=20000, PromiseGet(promise=Promise(id=p16, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:9.0], data=3), timeout=170796, tags=map[], createdOn=4000, completedOn=31000)))" err=<nil>
level=INFO msg=DST id=12379 t=998000|998999 req="PromiseRegister(awaiter=p17, awaited=p18)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p18, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:0.0 1:0.1], data=6), timeout=815128, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=14000)))" err=<nil>
level=INFO msg=DST id=12382 t=998000|998999 req="PromiseCreate(id=p02, param=Value(headers=map[], data=), timeout=207, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=17), value=Value(headers=map[], data=), timeout=602033, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=11000, completedOn=72000)))" err=<nil>
level=INFO msg=DST id=12386 t=999000|1000999 req="ScheduleCreate(id=s02, desc=, cron=2 * * * *, tags=map[], promiseId=s02.{{.timestamp}}, promiseTimeout=999681, promiseParam=Value(headers=map[], data=), promiseTags=map[0:6.0 1:6.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s02, desc=, cron=59 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s02.{{.timestamp}}, promiseTimeout=998962, promiseParam=Value(headers=map[0:5.0 1:5.1], data=18), promiseTags=map[0:1.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=3540000, createdOn=994000)))" err=<nil>
level=INFO msg=DST id=12388 t=999000|1000999 req="ScheduleDelete(id=s18)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12389 t=999000|1000999 req="ScheduleGet(id=s05)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s05, desc=, cron=48 * * * *, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true], promiseId=s05.{{.timestamp}}, promiseTimeout=987372, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2880000, createdOn=980000)))" err=<nil>
level=INFO msg=DST id=12375 t=998000|1000999 req="ScheduleCreate(id=s19, desc=, cron=45 * * * *, tags=map[0:1.0 resonate:invoke:dst resonate:timeout:true], promiseId=s19.{{.timestamp}}, promiseTimeout=999340, promiseParam=Value(headers=map[], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s19, desc=, cron=45 * * * *, tags=map[0:1.0 resonate:invoke:dst resonate:timeout:true], promiseId=s19.{{.timestamp}}, promiseTimeout=999340, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=2700000, createdOn=999000)))" err=<nil>
level=INFO msg=DST id=12383 t=999000|1000999 req="PromiseSubscribe(awaited=p01, address=addr17)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[0:2.0], data=), value=Value(headers=map[0:6.0], data=2), timeout=422358, tags=map[], createdOn=1000, completedOn=20000)))" err=<nil>
level=INFO msg=DST id=12384 t=999000|1000999 req="PromiseGet(id=p14)" res="Response(status=20000, PromiseGet(promise=Promise(id=p14, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:4.0 1:4.1], data=), timeout=153228, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=10000, completedOn=47000)))" err=<nil>
level=INFO msg=DST id=12385 t=999000|1000999 req="PromiseCreate(id=p02, param=Value(headers=map[0:2.0], data=8), timeout=593515, tags=map[0:2.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=17), value=Value(headers=map[], data=), timeout=602033, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=11000, completedOn=72000)))" err=<nil>
level=INFO msg=DST id=12387 t=999000|1000999 req="PromiseRegister(awaiter=p05, awaited=p18)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p18, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:0.0 1:0.1], data=6), timeout=815128, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=14000)))" err=<nil>
level=INFO msg=DST id=12391 t=999000|1000999 req="PromiseGet(id=p20)" res="Response(status=20000, PromiseGet(promise=Promise(id=p20, state=RESOLVED, param=Value(headers=map[], data=15), value=Value(headers=map[0:5.0 1:5.1], data=), timeout=878530, tags=map[resonate:invoke:dst], createdOn=3000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12390 t=999000|1001999 req="ScheduleCreate(id=s01, desc=, cron=43 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s01.{{.timestamp}}, promiseTimeout=999168, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=43 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s01.{{.timestamp}}, promiseTimeout=999168, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2580000, createdOn=1001000)))" err=<nil>
level=ERROR msg="DST is non linearizable, run with -v flag for more information" v=false
Error: DST failed for seed='4251'