DST: 2461 #1047
Description
DST Failed
DST run failed for seed=2461, ticks=1000, scenario=default, store=sqlite.
Seed
2461
Scenario
default
Store
sqlite
Commit
5514db3b6a3a0334fb74c30c5fba44f7af6dcee8
Command
go run ./... dst run --seed 2461 --ticks 1000 --scenario default --aio-store-sqlite-enable
Logs
level=INFO msg=DST seed=2461 ticks=1000 reqsPerTick=1:25 dst="DST(ids=23, headers=18, data=12, tags=10, backchannel=796)" system="System(api=API(size=232, subsystems=[]), aio=AIODST(subsystems=[router sender store]), config=Config(cms=764, sbs=498, cbs=522, pbs=74, sbs=76, tbs=67))"
level=INFO msg=DST id=0 t=0|999 req="ScheduleDelete(id=s14)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=3 t=1000|1999 req="PromiseComplete(id=p11, state=REJECTED, value=Value(headers=map[], data=))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=4 t=1000|1999 req="PromiseComplete(id=p16, state=RESOLVED, value=Value(headers=map[0:7.0 1:7.1 2:7.2], data=1))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=6 t=1000|1999 req="ScheduleDelete(id=s00)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=7 t=1000|1999 req="PromiseComplete(id=p19, state=REJECTED_CANCELED, value=Value(headers=map[0:10.0 1:10.1], data=11))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=9 t=1000|1999 req="ScheduleGet(id=s02)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=14 t=1000|1999 req="ScheduleGet(id=s00)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=15 t=1000|1999 req="ScheduleDelete(id=s03)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=16 t=1000|1999 req="ScheduleDelete(id=s21)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=18 t=1000|1999 req="ScheduleDelete(id=s22)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=19 t=1000|1999 req="ScheduleDelete(id=s01)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=1 t=1000|1999 req="PromiseGet(id=p13)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=5 t=1000|1999 req="PromiseRegister(awaiter=p10, awaited=p13)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=8 t=1000|1999 req="PromiseSubscribe(awaited=p03, address=addr01)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=17 t=1000|1999 req="PromiseRegister(awaiter=p03, awaited=p02)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=20 t=1000|1999 req="PromiseGet(id=p19)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=22 t=2000|2999 req="ScheduleDelete(id=s13)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=23 t=2000|2999 req="PromiseComplete(id=p06, state=REJECTED_CANCELED, value=Value(headers=map[0:14.0 1:14.1], data=))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=29 t=2000|2999 req="CallbackCreate(id=__resume:p17:p11, promiseId=p11, recv=\"dst\", mesg=Mesg(type=resume, root=p17, leaf=p11), timeout=267944)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=32 t=2000|2999 req="CallbackCreate(id=__notify:p15:cb10, promiseId=p15, recv=\"dst\", mesg=Mesg(type=notify, root=p15, leaf=), timeout=245973)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=37 t=2000|2999 req="PromiseComplete(id=p16, state=REJECTED_CANCELED, value=Value(headers=map[0:1.0], data=1))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12 t=1000|2999 req="ScheduleCreate(id=s14, desc=, cron=2 * * * *, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], promiseId=s14.{{.timestamp}}, promiseTimeout=989762, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s14, desc=, cron=2 * * * *, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], promiseId=s14.{{.timestamp}}, promiseTimeout=989762, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=120000, createdOn=2000)))" err=<nil>
level=INFO msg=DST id=24 t=2000|2999 req="PromiseGet(id=p17)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=25 t=2000|2999 req="PromiseGet(id=p11)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=26 t=2000|2999 req="PromiseGet(id=p03)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=28 t=2000|2999 req="PromiseRegister(awaiter=p02, awaited=p06)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=31 t=2000|2999 req="PromiseRegister(awaiter=p09, awaited=p22)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=34 t=2000|2999 req="PromiseSubscribe(awaited=p18, address=addr19)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=36 t=2000|2999 req="PromiseGet(id=p05)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=38 t=2000|2999 req="PromiseSubscribe(awaited=p09, address=addr03)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=39 t=2000|2999 req="PromiseRegister(awaiter=p06, awaited=p11)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=40 t=2000|2999 req="PromiseSubscribe(awaited=p06, address=addr20)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=42 t=3000|3999 req="ScheduleDelete(id=s17)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=33 t=2000|3999 req="ScheduleCreate(id=s01, desc=, cron=53 * * * *, tags=map[0:7.0], promiseId=s01.{{.timestamp}}, promiseTimeout=40467, promiseParam=Value(headers=map[0:5.0], data=), promiseTags=map[resonate:invoke:dst])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=53 * * * *, tags=map[0:7.0], promiseId=s01.{{.timestamp}}, promiseTimeout=40467, promiseParam=Value(headers=map[0:5.0], data=), promiseTags=map[resonate:invoke:dst], lastRunTime=0, nextRunTime=3180000, createdOn=3000)))" err=<nil>
level=INFO msg=DST id=35 t=2000|3999 req="ScheduleCreate(id=s10, desc=, cron=41 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=203308, promiseParam=Value(headers=map[0:10.0 1:10.1], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s10, desc=, cron=41 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=203308, promiseParam=Value(headers=map[0:10.0 1:10.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2460000, createdOn=3000)))" err=<nil>
level=INFO msg=DST id=2 t=1000|3999 req="PromiseCreate(id=p18, param=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p18, state=PENDING, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0], createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=10 t=1000|3999 req="TaskCreate(promise=PromiseCreate(id=p14, param=Value(headers=map[], data=4), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p14, processId=p14, ttl=1000, timeout=722472))" res="Response(status=20100, TaskCreate(promise=Promise(id=p14, state=PENDING, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=0), task=Task(id=__invoke:p14, processId=p14, state=CLAIMED, rootPromiseId=p14, recv=\"dst\", mesg=Mesg(type=invoke, root=p14, leaf=p14), timeout=722472, counter=1, attempt=0, ttl=1000, expiresAt=2000, createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=11 t=1000|3999 req="PromiseCreate(id=p16, param=Value(headers=map[], data=4), timeout=904133, tags=map[])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p16, state=PENDING, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=904133, tags=map[], createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=13 t=1000|3999 req="TaskCreate(promise=PromiseCreate(id=p17, param=Value(headers=map[0:15.0], data=), timeout=142955, tags=map[0:0.0 resonate:invoke:dst]), task=CreateTask(promiseId=p17, processId=p17, ttl=9223372036854775807, timeout=142955))" res="Response(status=20100, TaskCreate(promise=Promise(id=p17, state=PENDING, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[], data=), timeout=142955, tags=map[0:0.0 resonate:invoke:dst], createdOn=1000, completedOn=0), task=Task(id=__invoke:p17, processId=p17, state=CLAIMED, rootPromiseId=p17, recv=\"dst\", mesg=Mesg(type=invoke, root=p17, leaf=p17), timeout=142955, counter=1, attempt=0, ttl=9223372036854775807, expiresAt=9223372036854775807, createdOn=1000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=44 t=4000|4999 req="ScheduleCreate(id=s10, desc=, cron=59 * * * *, tags=map[resonate:invoke:dst], promiseId=s10.{{.timestamp}}, promiseTimeout=327226, promiseParam=Value(headers=map[0:11.0], data=), promiseTags=map[0:6.0 resonate:timeout:true])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s10, desc=, cron=41 * * * *, tags=map[], promiseId=s10.{{.timestamp}}, promiseTimeout=203308, promiseParam=Value(headers=map[0:10.0 1:10.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2460000, createdOn=3000)))" err=<nil>
level=INFO msg=DST id=46 t=4000|4999 req="CallbackCreate(id=__resume:p14:p21, promiseId=p21, recv=\"dst\", mesg=Mesg(type=resume, root=p14, leaf=p21), timeout=31068)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=50 t=4000|4999 req="ScheduleDelete(id=s02)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=51 t=4000|4999 req="ScheduleGet(id=s14)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s14, desc=, cron=2 * * * *, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], promiseId=s14.{{.timestamp}}, promiseTimeout=989762, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=120000, createdOn=2000)))" err=<nil>
level=INFO msg=DST id=52 t=4000|4999 req="PromiseComplete(id=p09, state=REJECTED, value=Value(headers=map[0:17.0 1:17.1 2:17.2], data=))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=53 t=4000|4999 req="ScheduleCreate(id=s01, desc=, cron=37 * * * *, tags=map[0:8.0 1:8.1 resonate:invoke:dst resonate:timeout:true], promiseId=s01.{{.timestamp}}, promiseTimeout=661329, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=53 * * * *, tags=map[0:7.0], promiseId=s01.{{.timestamp}}, promiseTimeout=40467, promiseParam=Value(headers=map[0:5.0], data=), promiseTags=map[resonate:invoke:dst], lastRunTime=0, nextRunTime=3180000, createdOn=3000)))" err=<nil>
level=INFO msg=DST id=57 t=4000|4999 req="PromiseComplete(id=p03, state=REJECTED_CANCELED, value=Value(headers=map[0:13.0], data=))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=41 t=3000|4999 req="ScheduleCreate(id=s11, desc=, cron=59 * * * *, tags=map[0:7.0], promiseId=s11.{{.timestamp}}, promiseTimeout=740054, promiseParam=Value(headers=map[0:2.0 1:2.1 2:2.2], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s11, desc=, cron=59 * * * *, tags=map[0:7.0], promiseId=s11.{{.timestamp}}, promiseTimeout=740054, promiseParam=Value(headers=map[0:2.0 1:2.1 2:2.2], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3540000, createdOn=4000)))" err=<nil>
level=INFO msg=DST id=30 t=2000|4999 req="TaskCreate(promise=PromiseCreate(id=p03, param=Value(headers=map[0:1.0], data=), timeout=951829, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p03, processId=p03, ttl=1000, timeout=951829))" res="Response(status=20100, TaskCreate(promise=Promise(id=p03, state=PENDING, param=Value(headers=map[0:1.0], data=), value=Value(headers=map[], data=), timeout=951829, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=2000, completedOn=0), task=Task(id=__invoke:p03, processId=p03, state=CLAIMED, rootPromiseId=p03, recv=\"dst\", mesg=Mesg(type=invoke, root=p03, leaf=p03), timeout=951829, counter=1, attempt=0, ttl=1000, expiresAt=3000, createdOn=2000, completedOn=0)))" err=<nil>
level=INFO msg=DST id=43 t=4000|4999 req="PromiseGet(id=p18)" res="Response(status=20000, PromiseGet(promise=Promise(id=p18, state=PENDING, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0], createdOn=1000, completedOn=0)))" err=<nil>
...
level=INFO msg=DST id=12501 t=991000|991999 req="PromiseCreate(id=p06, param=Value(headers=map[], data=), timeout=484050, tags=map[0:6.0 resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=414558, tags=map[0:7.0], createdOn=5000, completedOn=20000)))" err=<nil>
level=INFO msg=DST id=12503 t=991000|991999 req="TaskCreate(promise=PromiseCreate(id=p05, param=Value(headers=map[], data=10), timeout=337704, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p05, processId=p05, ttl=9223372036854775807, timeout=337704))" res="Response(status=20000, TaskCreate(promise=Promise(id=p05, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=11), timeout=684456, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=18000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12505 t=991000|991999 req="PromiseGet(id=p11)" res="Response(status=20000, PromiseGet(promise=Promise(id=p11, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=4), timeout=163048, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12506 t=991000|991999 req="PromiseSubscribe(awaited=p19, address=addr09)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p19, state=RESOLVED, param=Value(headers=map[], data=8), value=Value(headers=map[], data=), timeout=365320, tags=map[], createdOn=39000, completedOn=50000)))" err=<nil>
level=INFO msg=DST id=12507 t=991000|991999 req="PromiseCreate(id=p01, param=Value(headers=map[0:17.0 1:17.1 2:17.2], data=10), timeout=21831, tags=map[0:4.0])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000)))" err=<nil>
level=INFO msg=DST id=12509 t=991000|991999 req="PromiseGet(id=p21)" res="Response(status=20000, PromiseGet(promise=Promise(id=p21, state=RESOLVED, param=Value(headers=map[], data=9), value=Value(headers=map[0:0.0 1:0.1], data=), timeout=650707, tags=map[resonate:invoke:dst], createdOn=6000, completedOn=59000)))" err=<nil>
level=INFO msg=DST id=12511 t=992000|992999 req="ScheduleGet(id=s21)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s21, desc=, cron=34 * * * *, tags=map[resonate:invoke:dst], promiseId=s21.{{.timestamp}}, promiseTimeout=988327, promiseParam=Value(headers=map[0:3.0 1:3.1 2:3.2], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2040000, createdOn=975000)))" err=<nil>
level=INFO msg=DST id=12512 t=992000|992999 req="ScheduleGet(id=s09)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s09, desc=, cron=23 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=997899, promiseParam=Value(headers=map[0:9.0 1:9.1 2:9.2], data=), promiseTags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=1380000, createdOn=963000)))" err=<nil>
level=INFO msg=DST id=12514 t=992000|992999 req="CallbackCreate(id=__notify:p11:cb11, promiseId=p11, recv=\"dst\", mesg=Mesg(type=notify, root=p11, leaf=), timeout=998908)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p11, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=4), timeout=163048, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12517 t=992000|992999 req="ScheduleDelete(id=s03)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12519 t=992000|992999 req="CallbackCreate(id=__notify:p20:cb04, promiseId=p20, recv=\"dst\", mesg=Mesg(type=notify, root=p20, leaf=), timeout=998308)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p20, state=REJECTED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=556809, tags=map[], createdOn=21000, completedOn=60000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12521 t=992000|992999 req="ScheduleGet(id=s22)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12522 t=992000|992999 req="ScheduleDelete(id=s00)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12523 t=992000|992999 req="ScheduleGet(id=s19)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s19, desc=, cron=42 * * * *, tags=map[0:4.0], promiseId=s19.{{.timestamp}}, promiseTimeout=996028, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2520000, createdOn=968000)))" err=<nil>
level=INFO msg=DST id=12524 t=992000|992999 req="ScheduleDelete(id=s02)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12526 t=992000|992999 req="ScheduleDelete(id=s20)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12532 t=992000|992999 req="CallbackCreate(id=__notify:p21:cb13, promiseId=p21, recv=\"dst\", mesg=Mesg(type=notify, root=p21, leaf=), timeout=997537)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p21, state=RESOLVED, param=Value(headers=map[], data=9), value=Value(headers=map[0:0.0 1:0.1], data=), timeout=650707, tags=map[resonate:invoke:dst], createdOn=6000, completedOn=59000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12533 t=992000|992999 req="CallbackCreate(id=__notify:p18:cb01, promiseId=p18, recv=\"dst\", mesg=Mesg(type=notify, root=p18, leaf=), timeout=994736)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p18, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0], createdOn=1000, completedOn=25000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12504 t=991000|992999 req="ScheduleCreate(id=s05, desc=, cron=38 * * * *, tags=map[0:7.0], promiseId=s05.{{.timestamp}}, promiseTimeout=996521, promiseParam=Value(headers=map[0:17.0 1:17.1 2:17.2], data=10), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s05, desc=, cron=38 * * * *, tags=map[0:7.0], promiseId=s05.{{.timestamp}}, promiseTimeout=996521, promiseParam=Value(headers=map[0:17.0 1:17.1 2:17.2], data=10), promiseTags=map[], lastRunTime=0, nextRunTime=2280000, createdOn=992000)))" err=<nil>
level=INFO msg=DST id=12510 t=992000|992999 req="PromiseCreate(id=p13, param=Value(headers=map[0:15.0], data=), timeout=193692, tags=map[0:5.0 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[0:12.0], data=), timeout=563749, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=14000)))" err=<nil>
level=INFO msg=DST id=12513 t=992000|992999 req="PromiseRegister(awaiter=p20, awaited=p12)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12516 t=992000|992999 req="PromiseRegister(awaiter=p11, awaited=p01)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000)))" err=<nil>
level=INFO msg=DST id=12518 t=992000|992999 req="PromiseRegister(awaiter=p13, awaited=p12)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=0), timeout=945056, tags=map[resonate:invoke:dst], createdOn=16000, completedOn=103000)))" err=<nil>
level=INFO msg=DST id=12520 t=992000|992999 req="PromiseSubscribe(awaited=p10, address=addr10)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[0:16.0 1:16.1], data=6), value=Value(headers=map[0:8.0 1:8.1], data=), timeout=985087, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=19000, completedOn=39000)))" err=<nil>
level=INFO msg=DST id=12525 t=992000|992999 req="PromiseSubscribe(awaited=p06, address=addr05)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=414558, tags=map[0:7.0], createdOn=5000, completedOn=20000)))" err=<nil>
level=INFO msg=DST id=12527 t=992000|992999 req="PromiseSubscribe(awaited=p14, address=addr12)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000)))" err=<nil>
level=INFO msg=DST id=12528 t=992000|992999 req="PromiseSubscribe(awaited=p11, address=addr04)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p11, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=4), timeout=163048, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12529 t=992000|992999 req="PromiseSubscribe(awaited=p12, address=addr08)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=0), timeout=945056, tags=map[resonate:invoke:dst], createdOn=16000, completedOn=103000)))" err=<nil>
level=INFO msg=DST id=12531 t=992000|992999 req="PromiseRegister(awaiter=p22, awaited=p04)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p04, state=REJECTED, param=Value(headers=map[], data=10), value=Value(headers=map[], data=6), timeout=89633, tags=map[0:3.0 1:3.1 2:3.2 resonate:timeout:true], createdOn=16000, completedOn=30000)))" err=<nil>
level=INFO msg=DST id=12538 t=993000|993999 req="CallbackCreate(id=__resume:p00:p19, promiseId=p19, recv=\"dst\", mesg=Mesg(type=resume, root=p00, leaf=p19), timeout=997345)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p19, state=RESOLVED, param=Value(headers=map[], data=8), value=Value(headers=map[], data=), timeout=365320, tags=map[], createdOn=39000, completedOn=50000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12530 t=992000|993999 req="ScheduleCreate(id=s03, desc=, cron=56 * * * *, tags=map[resonate:invoke:dst], promiseId=s03.{{.timestamp}}, promiseTimeout=999582, promiseParam=Value(headers=map[0:14.0 1:14.1], data=), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s03, desc=, cron=56 * * * *, tags=map[resonate:invoke:dst], promiseId=s03.{{.timestamp}}, promiseTimeout=999582, promiseParam=Value(headers=map[0:14.0 1:14.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3360000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12534 t=993000|993999 req="PromiseRegister(awaiter=p18, awaited=p07)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12535 t=993000|993999 req="TaskCreate(promise=PromiseCreate(id=p02, param=Value(headers=map[0:5.0], data=6), timeout=818380, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p02, processId=p02, ttl=9223372036854775807, timeout=818380))" res="Response(status=20000, TaskCreate(promise=Promise(id=p02, state=REJECTED_CANCELED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=11), timeout=810339, tags=map[resonate:invoke:dst], createdOn=13000, completedOn=25000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12536 t=993000|993999 req="PromiseGet(id=p00)" res="Response(status=20000, PromiseGet(promise=Promise(id=p00, state=REJECTED_CANCELED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[0:5.0], data=7), timeout=77120, tags=map[0:7.0 resonate:invoke:dst], createdOn=9000, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12537 t=993000|993999 req="TaskCreate(promise=PromiseCreate(id=p11, param=Value(headers=map[], data=), timeout=936692, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p11, processId=p11, ttl=1000, timeout=936692))" res="Response(status=20000, TaskCreate(promise=Promise(id=p11, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=4), timeout=163048, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12539 t=993000|993999 req="TaskCreate(promise=PromiseCreate(id=p08, param=Value(headers=map[], data=1), timeout=232906, tags=map[0:3.0 1:3.1 2:3.2 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p08, processId=p08, ttl=5000, timeout=232906))" res="Response(status=20000, TaskCreate(promise=Promise(id=p08, state=REJECTED_CANCELED, param=Value(headers=map[0:14.0 1:14.1], data=6), value=Value(headers=map[0:7.0 1:7.1 2:7.2], data=3), timeout=186896, tags=map[0:7.0 resonate:invoke:dst], createdOn=7000, completedOn=12000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12541 t=993000|993999 req="PromiseGet(id=p14)" res="Response(status=20000, PromiseGet(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000)))" err=<nil>
level=INFO msg=DST id=12542 t=994000|994999 req="ScheduleDelete(id=s09)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12545 t=994000|994999 req="ScheduleDelete(id=s11)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12547 t=994000|994999 req="PromiseComplete(id=p05, state=REJECTED, value=Value(headers=map[0:11.0], data=2))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p05, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=11), timeout=684456, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=18000)))" err=<nil>
level=INFO msg=DST id=12548 t=994000|994999 req="CallbackCreate(id=__resume:p09:p01, promiseId=p01, recv=\"dst\", mesg=Mesg(type=resume, root=p09, leaf=p01), timeout=996102)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12515 t=992000|994999 req="ScheduleCreate(id=s03, desc=, cron=3 * * * *, tags=map[0:8.0 1:8.1 resonate:invoke:dst resonate:timeout:true], promiseId=s03.{{.timestamp}}, promiseTimeout=996809, promiseParam=Value(headers=map[0:14.0 1:14.1], data=5), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s03, desc=, cron=56 * * * *, tags=map[resonate:invoke:dst], promiseId=s03.{{.timestamp}}, promiseTimeout=999582, promiseParam=Value(headers=map[0:14.0 1:14.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3360000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12543 t=994000|994999 req="PromiseGet(id=p05)" res="Response(status=20000, PromiseGet(promise=Promise(id=p05, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=11), timeout=684456, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=7000, completedOn=18000)))" err=<nil>
level=INFO msg=DST id=12544 t=994000|994999 req="PromiseGet(id=p00)" res="Response(status=20000, PromiseGet(promise=Promise(id=p00, state=REJECTED_CANCELED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[0:5.0], data=7), timeout=77120, tags=map[0:7.0 resonate:invoke:dst], createdOn=9000, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12546 t=994000|994999 req="PromiseGet(id=p12)" res="Response(status=20000, PromiseGet(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=0), timeout=945056, tags=map[resonate:invoke:dst], createdOn=16000, completedOn=103000)))" err=<nil>
level=INFO msg=DST id=12549 t=994000|994999 req="TaskCreate(promise=PromiseCreate(id=p18, param=Value(headers=map[], data=), timeout=574851, tags=map[0:6.0 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p18, processId=p18, ttl=1000, timeout=574851))" res="Response(status=20000, TaskCreate(promise=Promise(id=p18, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0], createdOn=1000, completedOn=25000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12550 t=994000|994999 req="PromiseSubscribe(awaited=p18, address=addr12)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p18, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0], createdOn=1000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12551 t=994000|994999 req="PromiseCreate(id=p07, param=Value(headers=map[0:10.0 1:10.1], data=), timeout=866994, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p07, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=8), timeout=91363, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], createdOn=6000, completedOn=21000)))" err=<nil>
level=INFO msg=DST id=12552 t=994000|994999 req="PromiseGet(id=p00)" res="Response(status=20000, PromiseGet(promise=Promise(id=p00, state=REJECTED_CANCELED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[0:5.0], data=7), timeout=77120, tags=map[0:7.0 resonate:invoke:dst], createdOn=9000, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12553 t=994000|994999 req="TaskCreate(promise=PromiseCreate(id=p20, param=Value(headers=map[], data=), timeout=218537, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p20, processId=p20, ttl=2000, timeout=218537))" res="Response(status=20000, TaskCreate(promise=Promise(id=p20, state=REJECTED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=556809, tags=map[], createdOn=21000, completedOn=60000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12554 t=994000|994999 req="PromiseGet(id=p04)" res="Response(status=20000, PromiseGet(promise=Promise(id=p04, state=REJECTED, param=Value(headers=map[], data=10), value=Value(headers=map[], data=6), timeout=89633, tags=map[0:3.0 1:3.1 2:3.2 resonate:timeout:true], createdOn=16000, completedOn=30000)))" err=<nil>
level=INFO msg=DST id=12555 t=995000|995999 req="PromiseComplete(id=p11, state=REJECTED_CANCELED, value=Value(headers=map[0:14.0 1:14.1], data=7))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p11, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=4), timeout=163048, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12560 t=995000|995999 req="ScheduleCreate(id=s19, desc=, cron=41 * * * *, tags=map[0:6.0 resonate:timeout:true], promiseId=s19.{{.timestamp}}, promiseTimeout=996374, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s19, desc=, cron=42 * * * *, tags=map[0:4.0], promiseId=s19.{{.timestamp}}, promiseTimeout=996028, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2520000, createdOn=968000)))" err=<nil>
level=INFO msg=DST id=12563 t=995000|995999 req="ScheduleGet(id=s09)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12564 t=995000|995999 req="CallbackCreate(id=__notify:p20:cb17, promiseId=p20, recv=\"dst\", mesg=Mesg(type=notify, root=p20, leaf=), timeout=998396)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p20, state=REJECTED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=556809, tags=map[], createdOn=21000, completedOn=60000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12567 t=995000|995999 req="ScheduleGet(id=s14)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s14, desc=, cron=44 * * * *, tags=map[], promiseId=s14.{{.timestamp}}, promiseTimeout=989362, promiseParam=Value(headers=map[0:13.0], data=2), promiseTags=map[0:6.0 resonate:timeout:true], lastRunTime=0, nextRunTime=2640000, createdOn=990000)))" err=<nil>
level=INFO msg=DST id=12568 t=995000|995999 req="ScheduleDelete(id=s13)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12570 t=995000|995999 req="ScheduleGet(id=s03)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s03, desc=, cron=56 * * * *, tags=map[resonate:invoke:dst], promiseId=s03.{{.timestamp}}, promiseTimeout=999582, promiseParam=Value(headers=map[0:14.0 1:14.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3360000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12540 t=993000|995999 req="ScheduleCreate(id=s03, desc=, cron=57 * * * *, tags=map[resonate:invoke:dst], promiseId=s03.{{.timestamp}}, promiseTimeout=998585, promiseParam=Value(headers=map[], data=9), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s03, desc=, cron=56 * * * *, tags=map[resonate:invoke:dst], promiseId=s03.{{.timestamp}}, promiseTimeout=999582, promiseParam=Value(headers=map[0:14.0 1:14.1], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3360000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12556 t=995000|995999 req="PromiseSubscribe(awaited=p15, address=addr15)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p15, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=541891, tags=map[], createdOn=31000, completedOn=35000)))" err=<nil>
level=INFO msg=DST id=12557 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p19, param=Value(headers=map[], data=), timeout=636492, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p19, processId=p19, ttl=3000, timeout=636492))" res="Response(status=20000, TaskCreate(promise=Promise(id=p19, state=RESOLVED, param=Value(headers=map[], data=8), value=Value(headers=map[], data=), timeout=365320, tags=map[], createdOn=39000, completedOn=50000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12558 t=995000|995999 req="PromiseSubscribe(awaited=p01, address=addr15)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000)))" err=<nil>
level=INFO msg=DST id=12559 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p14, param=Value(headers=map[0:10.0 1:10.1], data=0), timeout=166983, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p14, processId=p14, ttl=2000, timeout=166983))" res="Response(status=20000, TaskCreate(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12561 t=995000|995999 req="PromiseRegister(awaiter=p21, awaited=p00)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p00, state=REJECTED_CANCELED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[0:5.0], data=7), timeout=77120, tags=map[0:7.0 resonate:invoke:dst], createdOn=9000, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12562 t=995000|995999 req="PromiseRegister(awaiter=p00, awaited=p07)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p07, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=8), timeout=91363, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], createdOn=6000, completedOn=21000)))" err=<nil>
level=INFO msg=DST id=12565 t=995000|995999 req="PromiseSubscribe(awaited=p10, address=addr02)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[0:16.0 1:16.1], data=6), value=Value(headers=map[0:8.0 1:8.1], data=), timeout=985087, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=19000, completedOn=39000)))" err=<nil>
level=INFO msg=DST id=12566 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p20, param=Value(headers=map[0:2.0 1:2.1 2:2.2], data=), timeout=420689, tags=map[0:6.0 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p20, processId=p20, ttl=5000, timeout=420689))" res="Response(status=20000, TaskCreate(promise=Promise(id=p20, state=REJECTED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=556809, tags=map[], createdOn=21000, completedOn=60000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12569 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p18, param=Value(headers=map[], data=7), timeout=112694, tags=map[0:8.0 1:8.1 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p18, processId=p18, ttl=2000, timeout=112694))" res="Response(status=20000, TaskCreate(promise=Promise(id=p18, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=704441, tags=map[0:7.0], createdOn=1000, completedOn=25000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12571 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p01, param=Value(headers=map[], data=), timeout=951826, tags=map[0:0.0 resonate:invoke:dst]), task=CreateTask(promiseId=p01, processId=p01, ttl=5000, timeout=951826))" res="Response(status=20000, TaskCreate(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12582 t=997000|997000 req="CallbackCreate(id=__resume:p20:p20, promiseId=p20, recv=\"dst\", mesg=Mesg(type=resume, root=p20, leaf=p20), timeout=999741)" res=<nil> err="The request is invalid"
level=INFO msg=DST id=12573 t=996000|996999 req="PromiseComplete(id=p14, state=REJECTED, value=Value(headers=map[0:7.0 1:7.1 2:7.2], data=9))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000)))" err=<nil>
level=INFO msg=DST id=12575 t=996000|996999 req="CallbackCreate(id=__notify:p11:cb03, promiseId=p11, recv=\"dst\", mesg=Mesg(type=notify, root=p11, leaf=), timeout=997566)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p11, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[], data=4), timeout=163048, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12572 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p04, param=Value(headers=map[], data=7), timeout=947950, tags=map[0:8.0 1:8.1 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p04, processId=p04, ttl=5000, timeout=947950))" res="Response(status=20000, TaskCreate(promise=Promise(id=p04, state=REJECTED, param=Value(headers=map[], data=10), value=Value(headers=map[], data=6), timeout=89633, tags=map[0:3.0 1:3.1 2:3.2 resonate:timeout:true], createdOn=16000, completedOn=30000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12574 t=996000|996999 req="PromiseSubscribe(awaited=p19, address=addr10)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p19, state=RESOLVED, param=Value(headers=map[], data=8), value=Value(headers=map[], data=), timeout=365320, tags=map[], createdOn=39000, completedOn=50000)))" err=<nil>
level=INFO msg=DST id=12576 t=996000|996999 req="PromiseRegister(awaiter=p21, awaited=p14)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000)))" err=<nil>
level=INFO msg=DST id=12577 t=996000|997999 req="ScheduleCreate(id=s12, desc=, cron=23 * * * *, tags=map[], promiseId=s12.{{.timestamp}}, promiseTimeout=996575, promiseParam=Value(headers=map[], data=), promiseTags=map[0:5.0 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s12, desc=, cron=23 * * * *, tags=map[], promiseId=s12.{{.timestamp}}, promiseTimeout=996575, promiseParam=Value(headers=map[], data=), promiseTags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=1380000, createdOn=997000)))" err=<nil>
level=INFO msg=DST id=12578 t=997000|997999 req="PromiseCreate(id=p00, param=Value(headers=map[0:16.0 1:16.1], data=11), timeout=515050, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p00, state=REJECTED_CANCELED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[0:5.0], data=7), timeout=77120, tags=map[0:7.0 resonate:invoke:dst], createdOn=9000, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12579 t=997000|997999 req="TaskCreate(promise=PromiseCreate(id=p19, param=Value(headers=map[0:6.0 1:6.1], data=8), timeout=94949, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p19, processId=p19, ttl=5000, timeout=94949))" res="Response(status=20000, TaskCreate(promise=Promise(id=p19, state=RESOLVED, param=Value(headers=map[], data=8), value=Value(headers=map[], data=), timeout=365320, tags=map[], createdOn=39000, completedOn=50000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12580 t=997000|997999 req="PromiseCreate(id=p12, param=Value(headers=map[], data=), timeout=959298, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=0), timeout=945056, tags=map[resonate:invoke:dst], createdOn=16000, completedOn=103000)))" err=<nil>
level=INFO msg=DST id=12581 t=997000|997999 req="PromiseCreate(id=p01, param=Value(headers=map[], data=), timeout=206366, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000)))" err=<nil>
level=INFO msg=DST id=12583 t=997000|997999 req="PromiseRegister(awaiter=p07, awaited=p01)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p01, state=RESOLVED, param=Value(headers=map[0:8.0 1:8.1], data=), value=Value(headers=map[], data=4), timeout=987860, tags=map[], createdOn=20000, completedOn=40000)))" err=<nil>
level=INFO msg=DST id=12585 t=998000|998999 req="ScheduleDelete(id=s02)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12588 t=998000|998999 req="CallbackCreate(id=__resume:p16:p06, promiseId=p06, recv=\"dst\", mesg=Mesg(type=resume, root=p16, leaf=p06), timeout=998507)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p06, state=RESOLVED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=7), timeout=414558, tags=map[0:7.0], createdOn=5000, completedOn=20000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12589 t=998000|998999 req="ScheduleDelete(id=s22)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12590 t=998000|998999 req="CallbackCreate(id=__notify:p03:cb09, promiseId=p03, recv=\"dst\", mesg=Mesg(type=notify, root=p03, leaf=), timeout=998717)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p03, state=REJECTED, param=Value(headers=map[0:1.0], data=), value=Value(headers=map[], data=2), timeout=951829, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=2000, completedOn=11000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12584 t=998000|998999 req="PromiseCreate(id=p14, param=Value(headers=map[], data=1), timeout=909571, tags=map[0:8.0 1:8.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000)))" err=<nil>
level=INFO msg=DST id=12586 t=998000|998999 req="PromiseCreate(id=p02, param=Value(headers=map[], data=), timeout=467798, tags=map[0:7.0])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p02, state=REJECTED_CANCELED, param=Value(headers=map[], data=2), value=Value(headers=map[], data=11), timeout=810339, tags=map[resonate:invoke:dst], createdOn=13000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12587 t=998000|998999 req="TaskCreate(promise=PromiseCreate(id=p14, param=Value(headers=map[0:1.0], data=), timeout=829667, tags=map[0:1.0 resonate:invoke:dst]), task=CreateTask(promiseId=p14, processId=p14, ttl=5000, timeout=829667))" res="Response(status=20000, TaskCreate(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[], data=4), value=Value(headers=map[], data=), timeout=722472, tags=map[0:9.0 1:9.1 2:9.2 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=34000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12592 t=999000|1000999 req="PromiseComplete(id=p04, state=REJECTED, value=Value(headers=map[], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p04, state=REJECTED, param=Value(headers=map[], data=10), value=Value(headers=map[], data=6), timeout=89633, tags=map[0:3.0 1:3.1 2:3.2 resonate:timeout:true], createdOn=16000, completedOn=30000)))" err=<nil>
level=INFO msg=DST id=12593 t=999000|1000999 req="ScheduleGet(id=s18)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s18, desc=, cron=32 * * * *, tags=map[0:4.0], promiseId=s18.{{.timestamp}}, promiseTimeout=989682, promiseParam=Value(headers=map[0:3.0 1:3.1 2:3.2], data=4), promiseTags=map[0:1.0], lastRunTime=0, nextRunTime=1920000, createdOn=940000)))" err=<nil>
level=INFO msg=DST id=12597 t=999000|1000999 req="ScheduleCreate(id=s19, desc=, cron=48 * * * *, tags=map[0:4.0], promiseId=s19.{{.timestamp}}, promiseTimeout=999251, promiseParam=Value(headers=map[], data=3), promiseTags=map[0:8.0 1:8.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s19, desc=, cron=42 * * * *, tags=map[0:4.0], promiseId=s19.{{.timestamp}}, promiseTimeout=996028, promiseParam=Value(headers=map[], data=), promiseTags=map[], lastRunTime=0, nextRunTime=2520000, createdOn=968000)))" err=<nil>
level=INFO msg=DST id=12600 t=999000|1000999 req="ScheduleDelete(id=s17)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12595 t=999000|1000999 req="PromiseGet(id=p07)" res="Response(status=20000, PromiseGet(promise=Promise(id=p07, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=8), timeout=91363, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], createdOn=6000, completedOn=21000)))" err=<nil>
level=INFO msg=DST id=12596 t=999000|1000999 req="PromiseGet(id=p22)" res="Response(status=20000, PromiseGet(promise=Promise(id=p22, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:11.0], data=), timeout=520957, tags=map[resonate:invoke:dst], createdOn=20000, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12599 t=999000|1000999 req="TaskCreate(promise=PromiseCreate(id=p07, param=Value(headers=map[], data=), timeout=303895, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p07, processId=p07, ttl=9223372036854775807, timeout=303895))" res="Response(status=20000, TaskCreate(promise=Promise(id=p07, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=8), timeout=91363, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], createdOn=6000, completedOn=21000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12591 t=999000|1001999 req="ScheduleCreate(id=s11, desc=, cron=4 * * * *, tags=map[0:7.0], promiseId=s11.{{.timestamp}}, promiseTimeout=999381, promiseParam=Value(headers=map[], data=10), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s11, desc=, cron=4 * * * *, tags=map[0:7.0], promiseId=s11.{{.timestamp}}, promiseTimeout=999381, promiseParam=Value(headers=map[], data=10), promiseTags=map[], lastRunTime=0, nextRunTime=3840000, createdOn=1001000)))" err=<nil>
level=INFO msg=DST id=12594 t=999000|1001999 req="ScheduleCreate(id=s04, desc=, cron=24 * * * *, tags=map[], promiseId=s04.{{.timestamp}}, promiseTimeout=999579, promiseParam=Value(headers=map[0:11.0], data=1), promiseTags=map[0:1.0])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s04, desc=, cron=24 * * * *, tags=map[], promiseId=s04.{{.timestamp}}, promiseTimeout=999579, promiseParam=Value(headers=map[0:11.0], data=1), promiseTags=map[0:1.0], lastRunTime=0, nextRunTime=1440000, createdOn=1001000)))" err=<nil>
level=INFO msg=DST id=12598 t=999000|1001999 req="ScheduleCreate(id=s01, desc=, cron=15 * * * *, tags=map[0:6.0 resonate:timeout:true], promiseId=s01.{{.timestamp}}, promiseTimeout=999887, promiseParam=Value(headers=map[], data=2), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=15 * * * *, tags=map[0:6.0 resonate:timeout:true], promiseId=s01.{{.timestamp}}, promiseTimeout=999887, promiseParam=Value(headers=map[], data=2), promiseTags=map[], lastRunTime=0, nextRunTime=4500000, 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='2461'