DST: 19770

[github-actions]

DST Failed

DST run failed for seed=19770, ticks=1000, scenario=default, store=sqlite.

Seed

19770

Scenario

default

Store

sqlite

Commit

3625ce749e237177e4f992881950c6457aae3275

Command

go run ./... dst run --seed 19770 --ticks 1000 --scenario default --aio-store-sqlite-enable

Logs

level=INFO msg=DST seed=19770 ticks=1000 reqsPerTick=1:25 dst="DST(ids=18, headers=20, data=1, tags=6, backchannel=677)" system="System(api=API(size=321, subsystems=[]), aio=AIODST(subsystems=[router sender store]), config=Config(cms=145, sbs=473, cbs=595, pbs=3, sbs=33, tbs=96))"
level=INFO msg=DST id=0 t=0|999 req="PromiseComplete(id=p06, state=REJECTED_CANCELED, value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=6 t=0|999 req="ScheduleDelete(id=s15)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=9 t=0|999 req="ScheduleGet(id=s11)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=10 t=0|999 req="ScheduleDelete(id=s13)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=16 t=0|999 req="ScheduleDelete(id=s13)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=1 t=0|999 req="PromiseRegister(awaiter=p06, awaited=p11)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=5 t=0|999 req="PromiseGet(id=p16)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=7 t=0|999 req="PromiseGet(id=p10)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12 t=0|999 req="PromiseGet(id=p12)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=18 t=0|999 req="PromiseSubscribe(awaited=p02, address=addr03)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=19 t=1000|1999 req="CallbackCreate(id=__notify:p08:cb10, promiseId=p08, recv=\"dst\", mesg=Mesg(type=notify, root=p08, leaf=), timeout=290617)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=22 t=1000|1999 req="CallbackCreate(id=__notify:p10:cb06, promiseId=p10, recv=\"dst\", mesg=Mesg(type=notify, root=p10, leaf=), timeout=666581)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=28 t=1000|1999 req="PromiseComplete(id=p10, state=REJECTED, value=Value(headers=map[], data=0))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=30 t=1000|1999 req="CallbackCreate(id=__notify:p01:cb00, promiseId=p01, recv=\"dst\", mesg=Mesg(type=notify, root=p01, leaf=), timeout=972248)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=33 t=1000|1999 req="ScheduleDelete(id=s01)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=36 t=1000|1999 req="ScheduleDelete(id=s08)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=3 t=0|1999 req="ScheduleCreate(id=s00, desc=, cron=27 * * * *, tags=map[], promiseId=s00.{{.timestamp}}, promiseTimeout=951071, promiseParam=Value(headers=map[], data=), promiseTags=map[0:2.0 resonate:invoke:dst])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s00, desc=, cron=27 * * * *, tags=map[], promiseId=s00.{{.timestamp}}, promiseTimeout=951071, promiseParam=Value(headers=map[], data=), promiseTags=map[0:2.0 resonate:invoke:dst], lastRunTime=0, nextRunTime=1620000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=4 t=0|1999 req="ScheduleCreate(id=s09, desc=, cron=25 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=368894, promiseParam=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s09, desc=, cron=25 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=368894, promiseParam=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1500000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=13 t=0|1999 req="ScheduleCreate(id=s16, desc=, cron=57 * * * *, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], promiseId=s16.{{.timestamp}}, promiseTimeout=726343, promiseParam=Value(headers=map[0:4.0], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s16, desc=, cron=57 * * * *, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], promiseId=s16.{{.timestamp}}, promiseTimeout=726343, promiseParam=Value(headers=map[0:4.0], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=3420000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=14 t=0|1999 req="ScheduleCreate(id=s13, desc=, cron=10 * * * *, tags=map[0:4.0], promiseId=s13.{{.timestamp}}, promiseTimeout=851329, promiseParam=Value(headers=map[], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s13, desc=, cron=10 * * * *, tags=map[0:4.0], promiseId=s13.{{.timestamp}}, promiseTimeout=851329, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=600000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=20 t=1000|1999 req="PromiseRegister(awaiter=p08, awaited=p09)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=26 t=1000|1999 req="PromiseSubscribe(awaited=p03, address=addr13)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=34 t=1000|1999 req="PromiseRegister(awaiter=p06, awaited=p08)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=35 t=1000|1999 req="PromiseSubscribe(awaited=p14, address=addr15)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=37 t=1000|1999 req="PromiseRegister(awaiter=p17, awaited=p04)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=38 t=1000|1999 req="PromiseRegister(awaiter=p14, awaited=p00)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=41 t=2000|2999 req="ScheduleGet(id=s03)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=45 t=2000|2999 req="CallbackCreate(id=__resume:p12:p08, promiseId=p08, recv=\"dst\", mesg=Mesg(type=resume, root=p12, leaf=p08), timeout=150777)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=46 t=2000|2999 req="CallbackCreate(id=__notify:p14:cb00, promiseId=p14, recv=\"dst\", mesg=Mesg(type=notify, root=p14, leaf=), timeout=823556)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=47 t=2000|2999 req="CallbackCreate(id=__notify:p06:cb01, promiseId=p06, recv=\"dst\", mesg=Mesg(type=notify, root=p06, leaf=), timeout=249234)" res="Response(status=40400, CallbackCreate(promise=<nil>, callback=<nil>))" err=<nil>
level=INFO msg=DST id=49 t=2000|2999 req="ScheduleCreate(id=s09, desc=, cron=46 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=223514, promiseParam=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), promiseTags=map[0:0.0 resonate:timeout:true])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s09, desc=, cron=25 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=368894, promiseParam=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1500000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=50 t=2000|2999 req="ScheduleGet(id=s12)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=54 t=2000|2999 req="ScheduleGet(id=s01)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=56 t=2000|2999 req="ScheduleDelete(id=s04)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=27 t=1000|2999 req="ScheduleCreate(id=s04, desc=, cron=20 * * * *, tags=map[], promiseId=s04.{{.timestamp}}, promiseTimeout=835387, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:4.0])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s04, desc=, cron=20 * * * *, tags=map[], promiseId=s04.{{.timestamp}}, promiseTimeout=835387, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:4.0], lastRunTime=0, nextRunTime=1200000, createdOn=2000)))" err=<nil>
level=INFO msg=DST id=29 t=1000|2999 req="ScheduleCreate(id=s05, desc=, cron=18 * * * *, tags=map[0:0.0 resonate:timeout:true], promiseId=s05.{{.timestamp}}, promiseTimeout=557811, promiseParam=Value(headers=map[0:11.0 1:11.1], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s05, desc=, cron=18 * * * *, tags=map[0:0.0 resonate:timeout:true], promiseId=s05.{{.timestamp}}, promiseTimeout=557811, promiseParam=Value(headers=map[0:11.0 1:11.1], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1080000, createdOn=2000)))" err=<nil>
level=INFO msg=DST id=8 t=0|2999 req="PromiseCreate(id=p09, param=Value(headers=map[], data=0), timeout=977747, tags=map[])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p09, state=PENDING, param=Value(headers=map[], data=0), value=Value(headers=map[], data=), timeout=977747, tags=map[], createdOn=0, completedOn=0)))" err=<nil>
level=INFO msg=DST id=11 t=0|2999 req="PromiseCreate(id=p01, param=Value(headers=map[], data=0), timeout=898265, tags=map[0:4.0])" res="Response(status=20100, PromiseCreate(promise=Promise(id=p01, state=PENDING, param=Value(headers=map[], data=0), value=Value(headers=map[], data=), timeout=898265, tags=map[0:4.0], createdOn=0, completedOn=0)))" err=<nil>
level=INFO msg=DST id=15 t=0|2999 req="TaskCreate(promise=PromiseCreate(id=p07, param=Value(headers=map[], data=), timeout=694259, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p07, processId=p07, ttl=3000, timeout=694259))" res="Response(status=20100, TaskCreate(promise=Promise(id=p07, state=PENDING, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=0), task=Task(id=__invoke:p07, processId=p07, state=CLAIMED, rootPromiseId=p07, recv=\"dst\", mesg=Mesg(type=invoke, root=p07, leaf=p07), timeout=694259, counter=1, attempt=0, ttl=3000, expiresAt=3000, createdOn=0, completedOn=0)))" err=<nil>
level=INFO msg=DST id=17 t=0|2999 req="TaskCreate(promise=PromiseCreate(id=p11, param=Value(headers=map[0:15.0], data=), timeout=944231, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p11, processId=p11, ttl=1000, timeout=944231))" res="Response(status=20100, TaskCreate(promise=Promise(id=p11, state=PENDING, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[], data=), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=0), task=Task(id=__invoke:p11, processId=p11, state=CLAIMED, rootPromiseId=p11, recv=\"dst\", mesg=Mesg(type=invoke, root=p11, leaf=p11), timeout=944231, counter=1, attempt=0, ttl=1000, expiresAt=1000, createdOn=0, completedOn=0)))" err=<nil>
level=INFO msg=DST id=42 t=2000|2999 req="PromiseRegister(awaiter=p14, awaited=p10)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=43 t=2000|2999 req="PromiseSubscribe(awaited=p17, address=addr16)" res="Response(status=40400, PromiseSubscribe(promise=<nil>))" err=<nil>
level=INFO msg=DST id=51 t=2000|2999 req="PromiseGet(id=p14)" res="Response(status=40400, PromiseGet(promise=<nil>))" err=<nil>
level=INFO msg=DST id=52 t=2000|2999 req="PromiseRegister(awaiter=p09, awaited=p13)" res="Response(status=40400, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=58 t=3000|3999 req="PromiseComplete(id=p02, state=REJECTED, value=Value(headers=map[0:13.0], data=0))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=60 t=3000|3999 req="PromiseComplete(id=p10, state=REJECTED, value=Value(headers=map[], data=))" res="Response(status=40400, PromiseComplete(promise=<nil>))" err=<nil>
level=INFO msg=DST id=61 t=3000|3999 req="ScheduleGet(id=s09)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s09, desc=, cron=25 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=368894, promiseParam=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1500000, createdOn=1000)))" err=<nil>
level=INFO msg=DST id=48 t=2000|3999 req="ScheduleCreate(id=s01, desc=, cron=39 * * * *, tags=map[0:4.0], promiseId=s01.{{.timestamp}}, promiseTimeout=665550, promiseParam=Value(headers=map[], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=39 * * * *, tags=map[0:4.0], promiseId=s01.{{.timestamp}}, promiseTimeout=665550, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=2340000, createdOn=3000)))" err=<nil>
level=INFO msg=DST id=55 t=2000|3999 req="ScheduleCreate(id=s06, desc=, cron=5 * * * *, tags=map[0:2.0 resonate:invoke:dst], promiseId=s06.{{.timestamp}}, promiseTimeout=990422, promiseParam=Value(headers=map[], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s06, desc=, cron=5 * * * *, tags=map[0:2.0 resonate:invoke:dst], promiseId=s06.{{.timestamp}}, promiseTimeout=990422, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=300000, createdOn=3000)))" err=<nil>

...

level=INFO msg=DST id=12204 t=994000|994999 req="CallbackCreate(id=__resume:p05:p06, promiseId=p06, recv=\"dst\", mesg=Mesg(type=resume, root=p05, leaf=p06), timeout=998150)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p06, state=REJECTED_CANCELED, param=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), value=Value(headers=map[], data=0), timeout=844908, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12205 t=994000|994999 req="PromiseComplete(id=p05, state=REJECTED_CANCELED, value=Value(headers=map[], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p05, state=REJECTED_CANCELED, param=Value(headers=map[0:6.0 1:6.1], data=0), value=Value(headers=map[], data=0), timeout=302215, tags=map[], createdOn=9000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12206 t=994000|994999 req="PromiseSubscribe(awaited=p02, address=addr00)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:12.0 1:12.1 2:12.2], data=0), timeout=414313, tags=map[0:4.0 resonate:invoke:dst], createdOn=17000, completedOn=45000)))" err=<nil>
level=INFO msg=DST id=12207 t=994000|994999 req="PromiseSubscribe(awaited=p07, address=addr03)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p07, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:18.0], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=26000)))" err=<nil>
level=INFO msg=DST id=12208 t=995000|995999 req="PromiseComplete(id=p16, state=RESOLVED, value=Value(headers=map[], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p16, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=983923, tags=map[resonate:invoke:dst], createdOn=1000, completedOn=7000)))" err=<nil>
level=INFO msg=DST id=12210 t=995000|995999 req="ScheduleDelete(id=s05)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12211 t=995000|995999 req="ScheduleGet(id=s07)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s07, desc=, cron=14 * * * *, tags=map[], promiseId=s07.{{.timestamp}}, promiseTimeout=996217, promiseParam=Value(headers=map[], data=), promiseTags=map[resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=4440000, createdOn=977000)))" err=<nil>
level=INFO msg=DST id=12212 t=995000|995999 req="ScheduleCreate(id=s17, desc=, cron=24 * * * *, tags=map[], promiseId=s17.{{.timestamp}}, promiseTimeout=997409, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s17, desc=, cron=30 * * * *, tags=map[], promiseId=s17.{{.timestamp}}, promiseTimeout=993096, promiseParam=Value(headers=map[], data=), promiseTags=map[0:4.0], lastRunTime=0, nextRunTime=1800000, createdOn=991000)))" err=<nil>
level=INFO msg=DST id=12213 t=995000|995999 req="ScheduleCreate(id=s02, desc=, cron=59 * * * *, tags=map[0:4.0], promiseId=s02.{{.timestamp}}, promiseTimeout=997153, promiseParam=Value(headers=map[0:0.0 1:0.1], data=0), promiseTags=map[0:0.0 resonate:timeout:true])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s02, desc=, cron=20 * * * *, tags=map[0:4.0], promiseId=s02.{{.timestamp}}, promiseTimeout=958639, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1200000, createdOn=946000)))" err=<nil>
level=INFO msg=DST id=12215 t=995000|995999 req="CallbackCreate(id=__resume:p01:p11, promiseId=p11, recv=\"dst\", mesg=Mesg(type=resume, root=p01, leaf=p11), timeout=996736)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=49000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12218 t=995000|995999 req="CallbackCreate(id=__notify:p12:cb00, promiseId=p12, recv=\"dst\", mesg=Mesg(type=notify, root=p12, leaf=), timeout=999135)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:19.0], data=), timeout=336057, tags=map[], createdOn=6000, completedOn=16000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12219 t=995000|995999 req="ScheduleGet(id=s08)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s08, desc=, cron=18 * * * *, tags=map[], promiseId=s08.{{.timestamp}}, promiseTimeout=996745, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1080000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12220 t=995000|995999 req="ScheduleDelete(id=s17)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12221 t=995000|995999 req="PromiseComplete(id=p12, state=RESOLVED, value=Value(headers=map[0:6.0 1:6.1], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:19.0], data=), timeout=336057, tags=map[], createdOn=6000, completedOn=16000)))" err=<nil>
level=INFO msg=DST id=12224 t=995000|995999 req="ScheduleDelete(id=s08)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12226 t=995000|995999 req="ScheduleGet(id=s17)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s17, desc=, cron=30 * * * *, tags=map[], promiseId=s17.{{.timestamp}}, promiseTimeout=993096, promiseParam=Value(headers=map[], data=), promiseTags=map[0:4.0], lastRunTime=0, nextRunTime=1800000, createdOn=991000)))" err=<nil>
level=INFO msg=DST id=12228 t=995000|995999 req="ScheduleCreate(id=s15, desc=, cron=15 * * * *, tags=map[], promiseId=s15.{{.timestamp}}, promiseTimeout=995114, promiseParam=Value(headers=map[0:16.0], data=0), promiseTags=map[0:2.0 resonate:invoke:dst])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s15, desc=, cron=33 * * * *, tags=map[0:2.0 resonate:invoke:dst], promiseId=s15.{{.timestamp}}, promiseTimeout=999575, promiseParam=Value(headers=map[0:8.0], data=), promiseTags=map[0:2.0 resonate:invoke:dst], lastRunTime=0, nextRunTime=1980000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12229 t=995000|995999 req="ScheduleGet(id=s16)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12230 t=995000|995999 req="PromiseComplete(id=p02, state=REJECTED, value=Value(headers=map[0:9.0 1:9.1], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:12.0 1:12.1 2:12.2], data=0), timeout=414313, tags=map[0:4.0 resonate:invoke:dst], createdOn=17000, completedOn=45000)))" err=<nil>
level=INFO msg=DST id=12214 t=995000|995999 req="TaskCreate(promise=PromiseCreate(id=p00, param=Value(headers=map[0:13.0], data=0), timeout=539858, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p00, processId=p00, ttl=9223372036854775807, timeout=539858))" res="Response(status=20000, TaskCreate(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:14.0 1:14.1], data=), value=Value(headers=map[], data=), timeout=922944, tags=map[resonate:invoke:dst], createdOn=2000, completedOn=8000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12217 t=995000|995999 req="PromiseCreate(id=p10, param=Value(headers=map[], data=0), timeout=834414, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[0:0.0 1:0.1], data=0), value=Value(headers=map[], data=0), timeout=192642, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12222 t=995000|995999 req="PromiseSubscribe(awaited=p07, address=addr09)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p07, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:18.0], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=26000)))" err=<nil>
level=INFO msg=DST id=12223 t=995000|995999 req="PromiseCreate(id=p00, param=Value(headers=map[], data=), timeout=723729, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:14.0 1:14.1], data=), value=Value(headers=map[], data=), timeout=922944, tags=map[resonate:invoke:dst], createdOn=2000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12225 t=995000|995999 req="PromiseRegister(awaiter=p06, awaited=p08)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p08, state=RESOLVED, param=Value(headers=map[], data=0), value=Value(headers=map[0:5.0 1:5.1], data=0), timeout=266345, tags=map[resonate:invoke:dst], createdOn=1000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12227 t=995000|995999 req="PromiseGet(id=p13)" res="Response(status=20000, PromiseGet(promise=Promise(id=p13, state=REJECTED_CANCELED, param=Value(headers=map[0:9.0 1:9.1], data=), value=Value(headers=map[0:18.0], data=), timeout=568828, tags=map[0:0.0 resonate:timeout:true], createdOn=17000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12231 t=996000|996999 req="PromiseComplete(id=p14, state=REJECTED, value=Value(headers=map[0:10.0], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=0), timeout=215100, tags=map[0:4.0 resonate:invoke:dst], createdOn=2000, completedOn=5000)))" err=<nil>
level=INFO msg=DST id=12238 t=996000|996999 req="ScheduleDelete(id=s10)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12241 t=996000|996999 req="ScheduleDelete(id=s09)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12245 t=996000|996999 req="ScheduleCreate(id=s07, desc=, cron=20 * * * *, tags=map[], promiseId=s07.{{.timestamp}}, promiseTimeout=998567, promiseParam=Value(headers=map[], data=), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s07, desc=, cron=14 * * * *, tags=map[], promiseId=s07.{{.timestamp}}, promiseTimeout=996217, promiseParam=Value(headers=map[], data=), promiseTags=map[resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=4440000, createdOn=977000)))" err=<nil>
level=INFO msg=DST id=12246 t=996000|996999 req="CallbackCreate(id=__resume:p00:p05, promiseId=p05, recv=\"dst\", mesg=Mesg(type=resume, root=p00, leaf=p05), timeout=998754)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p05, state=REJECTED_CANCELED, param=Value(headers=map[0:6.0 1:6.1], data=0), value=Value(headers=map[], data=0), timeout=302215, tags=map[], createdOn=9000, completedOn=23000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12248 t=996000|996999 req="PromiseComplete(id=p01, state=RESOLVED, value=Value(headers=map[0:4.0], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[], data=0), value=Value(headers=map[0:18.0], data=), timeout=898265, tags=map[0:4.0], createdOn=0, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12251 t=996000|996999 req="ScheduleDelete(id=s05)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12209 t=995000|996999 req="ScheduleCreate(id=s16, desc=, cron=13 * * * *, tags=map[], promiseId=s16.{{.timestamp}}, promiseTimeout=999710, promiseParam=Value(headers=map[0:0.0 1:0.1], data=), promiseTags=map[0:5.0 resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s16, desc=, cron=13 * * * *, tags=map[], promiseId=s16.{{.timestamp}}, promiseTimeout=999710, promiseParam=Value(headers=map[0:0.0 1:0.1], data=), promiseTags=map[0:5.0 resonate:timeout:true], lastRunTime=0, nextRunTime=4380000, createdOn=996000)))" err=<nil>
level=INFO msg=DST id=12216 t=995000|996999 req="ScheduleCreate(id=s11, desc=, cron=55 * * * *, tags=map[], promiseId=s11.{{.timestamp}}, promiseTimeout=997667, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:0.0 resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s11, desc=, cron=55 * * * *, tags=map[], promiseId=s11.{{.timestamp}}, promiseTimeout=997667, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:0.0 resonate:timeout:true], lastRunTime=0, nextRunTime=3300000, createdOn=996000)))" err=<nil>
level=INFO msg=DST id=12232 t=996000|996999 req="PromiseGet(id=p17)" res="Response(status=20000, PromiseGet(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=), timeout=180777, tags=map[0:0.0 resonate:timeout:true], createdOn=1000, completedOn=16000)))" err=<nil>
level=INFO msg=DST id=12233 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p11, param=Value(headers=map[], data=), timeout=136932, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p11, processId=p11, ttl=2000, timeout=136932))" res="Response(status=20000, TaskCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=49000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12234 t=996000|996999 req="PromiseGet(id=p11)" res="Response(status=20000, PromiseGet(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=49000)))" err=<nil>
level=INFO msg=DST id=12235 t=996000|996999 req="PromiseCreate(id=p11, param=Value(headers=map[0:8.0], data=0), timeout=699063, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=49000)))" err=<nil>
level=INFO msg=DST id=12236 t=996000|996999 req="PromiseSubscribe(awaited=p02, address=addr10)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:12.0 1:12.1 2:12.2], data=0), timeout=414313, tags=map[0:4.0 resonate:invoke:dst], createdOn=17000, completedOn=45000)))" err=<nil>
level=INFO msg=DST id=12237 t=996000|996999 req="PromiseGet(id=p10)" res="Response(status=20000, PromiseGet(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[0:0.0 1:0.1], data=0), value=Value(headers=map[], data=0), timeout=192642, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12239 t=996000|996999 req="PromiseCreate(id=p11, param=Value(headers=map[0:5.0 1:5.1], data=0), timeout=978109, tags=map[0:2.0 resonate:invoke:dst])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=49000)))" err=<nil>
level=INFO msg=DST id=12240 t=996000|996999 req="PromiseSubscribe(awaited=p01, address=addr16)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[], data=0), value=Value(headers=map[0:18.0], data=), timeout=898265, tags=map[0:4.0], createdOn=0, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12242 t=996000|996999 req="PromiseGet(id=p07)" res="Response(status=20000, PromiseGet(promise=Promise(id=p07, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:18.0], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=26000)))" err=<nil>
level=INFO msg=DST id=12243 t=996000|996999 req="PromiseCreate(id=p04, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=0), timeout=437613, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p04, state=RESOLVED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=), timeout=946567, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=7000)))" err=<nil>
level=INFO msg=DST id=12244 t=996000|996999 req="PromiseGet(id=p02)" res="Response(status=20000, PromiseGet(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:12.0 1:12.1 2:12.2], data=0), timeout=414313, tags=map[0:4.0 resonate:invoke:dst], createdOn=17000, completedOn=45000)))" err=<nil>
level=INFO msg=DST id=12247 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p04, param=Value(headers=map[0:9.0 1:9.1], data=0), timeout=347405, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p04, processId=p04, ttl=9223372036854775807, timeout=347405))" res="Response(status=20000, TaskCreate(promise=Promise(id=p04, state=RESOLVED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=), timeout=946567, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=7000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12249 t=996000|996999 req="PromiseRegister(awaiter=p07, awaited=p06)" res="Response(status=20000, PromiseRegister(promise=Promise(id=p06, state=REJECTED_CANCELED, param=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), value=Value(headers=map[], data=0), timeout=844908, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12250 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p07, param=Value(headers=map[], data=), timeout=425822, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p07, processId=p07, ttl=1000, timeout=425822))" res="Response(status=20000, TaskCreate(promise=Promise(id=p07, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:18.0], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=26000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12252 t=996000|996999 req="TaskCreate(promise=PromiseCreate(id=p02, param=Value(headers=map[0:4.0], data=0), timeout=921751, tags=map[resonate:invoke:dst]), task=CreateTask(promiseId=p02, processId=p02, ttl=3000, timeout=921751))" res="Response(status=20000, TaskCreate(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:12.0 1:12.1 2:12.2], data=0), timeout=414313, tags=map[0:4.0 resonate:invoke:dst], createdOn=17000, completedOn=45000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12253 t=997000|997999 req="ScheduleGet(id=s07)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s07, desc=, cron=14 * * * *, tags=map[], promiseId=s07.{{.timestamp}}, promiseTimeout=996217, promiseParam=Value(headers=map[], data=), promiseTags=map[resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=4440000, createdOn=977000)))" err=<nil>
level=INFO msg=DST id=12254 t=997000|997999 req="CallbackCreate(id=__resume:p15:p17, promiseId=p17, recv=\"dst\", mesg=Mesg(type=resume, root=p15, leaf=p17), timeout=997576)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=), timeout=180777, tags=map[0:0.0 resonate:timeout:true], createdOn=1000, completedOn=16000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12255 t=997000|997999 req="PromiseComplete(id=p09, state=REJECTED, value=Value(headers=map[], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p09, state=REJECTED_CANCELED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=0), timeout=977747, tags=map[], createdOn=0, completedOn=9000)))" err=<nil>
level=INFO msg=DST id=12256 t=997000|997999 req="ScheduleGet(id=s13)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s13, desc=, cron=58 * * * *, tags=map[], promiseId=s13.{{.timestamp}}, promiseTimeout=997996, promiseParam=Value(headers=map[0:16.0], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3480000, createdOn=992000)))" err=<nil>
level=INFO msg=DST id=12257 t=997000|997999 req="ScheduleDelete(id=s16)" res="Response(status=20400, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12258 t=997000|997999 req="ScheduleDelete(id=s10)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12263 t=997000|997999 req="ScheduleGet(id=s05)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12264 t=997000|997999 req="CallbackCreate(id=__resume:p16:p09, promiseId=p09, recv=\"dst\", mesg=Mesg(type=resume, root=p16, leaf=p09), timeout=998728)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p09, state=REJECTED_CANCELED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=0), timeout=977747, tags=map[], createdOn=0, completedOn=9000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12265 t=997000|997999 req="ScheduleCreate(id=s03, desc=, cron=37 * * * *, tags=map[0:0.0 resonate:timeout:true], promiseId=s03.{{.timestamp}}, promiseTimeout=997330, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:0.0 resonate:timeout:true])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s03, desc=, cron=9 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s03.{{.timestamp}}, promiseTimeout=991859, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=4140000, createdOn=990000)))" err=<nil>
level=INFO msg=DST id=12266 t=997000|997999 req="PromiseComplete(id=p14, state=RESOLVED, value=Value(headers=map[0:8.0], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=0), timeout=215100, tags=map[0:4.0 resonate:invoke:dst], createdOn=2000, completedOn=5000)))" err=<nil>
level=INFO msg=DST id=12268 t=997000|997999 req="ScheduleGet(id=s15)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s15, desc=, cron=33 * * * *, tags=map[0:2.0 resonate:invoke:dst], promiseId=s15.{{.timestamp}}, promiseTimeout=999575, promiseParam=Value(headers=map[0:8.0], data=), promiseTags=map[0:2.0 resonate:invoke:dst], lastRunTime=0, nextRunTime=1980000, createdOn=993000)))" err=<nil>
level=INFO msg=DST id=12269 t=997000|997999 req="ScheduleCreate(id=s00, desc=, cron=5 * * * *, tags=map[], promiseId=s00.{{.timestamp}}, promiseTimeout=999376, promiseParam=Value(headers=map[0:18.0], data=0), promiseTags=map[])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s00, desc=, cron=28 * * * *, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], promiseId=s00.{{.timestamp}}, promiseTimeout=998116, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1680000, createdOn=979000)))" err=<nil>
level=INFO msg=DST id=12270 t=997000|997999 req="PromiseComplete(id=p01, state=REJECTED_CANCELED, value=Value(headers=map[0:0.0 1:0.1], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[], data=0), value=Value(headers=map[0:18.0], data=), timeout=898265, tags=map[0:4.0], createdOn=0, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12272 t=997000|997999 req="ScheduleDelete(id=s10)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12273 t=997000|997999 req="ScheduleDelete(id=s08)" res="Response(status=40401, ScheduleDelete())" err=<nil>
level=INFO msg=DST id=12259 t=997000|997999 req="PromiseGet(id=p10)" res="Response(status=20000, PromiseGet(promise=Promise(id=p10, state=REJECTED_CANCELED, param=Value(headers=map[0:0.0 1:0.1], data=0), value=Value(headers=map[], data=0), timeout=192642, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=25000)))" err=<nil>
level=INFO msg=DST id=12260 t=997000|997999 req="PromiseGet(id=p04)" res="Response(status=20000, PromiseGet(promise=Promise(id=p04, state=RESOLVED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=), timeout=946567, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=7000)))" err=<nil>
level=INFO msg=DST id=12261 t=997000|997999 req="TaskCreate(promise=PromiseCreate(id=p12, param=Value(headers=map[0:2.0 1:2.1 2:2.2], data=), timeout=25517, tags=map[0:4.0 resonate:invoke:dst]), task=CreateTask(promiseId=p12, processId=p12, ttl=3000, timeout=25517))" res="Response(status=20000, TaskCreate(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:19.0], data=), timeout=336057, tags=map[], createdOn=6000, completedOn=16000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12262 t=997000|997999 req="PromiseGet(id=p05)" res="Response(status=20000, PromiseGet(promise=Promise(id=p05, state=REJECTED_CANCELED, param=Value(headers=map[0:6.0 1:6.1], data=0), value=Value(headers=map[], data=0), timeout=302215, tags=map[], createdOn=9000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12267 t=997000|997999 req="PromiseSubscribe(awaited=p03, address=addr01)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p03, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[], data=), timeout=398461, tags=map[], createdOn=7000, completedOn=15000)))" err=<nil>
level=INFO msg=DST id=12271 t=997000|997999 req="PromiseCreate(id=p04, param=Value(headers=map[0:11.0 1:11.1], data=0), timeout=377440, tags=map[0:4.0])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p04, state=RESOLVED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=), timeout=946567, tags=map[resonate:invoke:dst resonate:timeout:true], createdOn=4000, completedOn=7000)))" err=<nil>
level=INFO msg=DST id=12274 t=998000|998999 req="PromiseComplete(id=p02, state=REJECTED_CANCELED, value=Value(headers=map[], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p02, state=RESOLVED, param=Value(headers=map[], data=), value=Value(headers=map[0:12.0 1:12.1 2:12.2], data=0), timeout=414313, tags=map[0:4.0 resonate:invoke:dst], createdOn=17000, completedOn=45000)))" err=<nil>
level=INFO msg=DST id=12278 t=998000|998999 req="PromiseComplete(id=p07, state=REJECTED_CANCELED, value=Value(headers=map[0:8.0], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p07, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:18.0], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=26000)))" err=<nil>
level=INFO msg=DST id=12279 t=998000|998999 req="ScheduleCreate(id=s00, desc=, cron=50 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s00.{{.timestamp}}, promiseTimeout=998797, promiseParam=Value(headers=map[0:9.0 1:9.1], data=0), promiseTags=map[0:2.0 resonate:invoke:dst])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s00, desc=, cron=28 * * * *, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], promiseId=s00.{{.timestamp}}, promiseTimeout=998116, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1680000, createdOn=979000)))" err=<nil>
level=INFO msg=DST id=12280 t=998000|998999 req="ScheduleGet(id=s01)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12281 t=998000|998999 req="PromiseComplete(id=p17, state=REJECTED, value=Value(headers=map[0:9.0 1:9.1], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=), timeout=180777, tags=map[0:0.0 resonate:timeout:true], createdOn=1000, completedOn=16000)))" err=<nil>
level=INFO msg=DST id=12282 t=998000|998999 req="ScheduleGet(id=s03)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s03, desc=, cron=9 * * * *, tags=map[resonate:invoke:dst resonate:timeout:true], promiseId=s03.{{.timestamp}}, promiseTimeout=991859, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=4140000, createdOn=990000)))" err=<nil>
level=INFO msg=DST id=12276 t=998000|998999 req="PromiseSubscribe(awaited=p09, address=addr10)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p09, state=REJECTED_CANCELED, param=Value(headers=map[], data=0), value=Value(headers=map[], data=0), timeout=977747, tags=map[], createdOn=0, completedOn=9000)))" err=<nil>
level=INFO msg=DST id=12277 t=998000|998999 req="PromiseCreate(id=p17, param=Value(headers=map[], data=0), timeout=399291, tags=map[resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=), timeout=180777, tags=map[0:0.0 resonate:timeout:true], createdOn=1000, completedOn=16000)))" err=<nil>
level=INFO msg=DST id=12283 t=998000|998999 req="PromiseSubscribe(awaited=p17, address=addr13)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p17, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=), timeout=180777, tags=map[0:0.0 resonate:timeout:true], createdOn=1000, completedOn=16000)))" err=<nil>
level=INFO msg=DST id=12284 t=998000|998999 req="PromiseSubscribe(awaited=p08, address=addr09)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p08, state=RESOLVED, param=Value(headers=map[], data=0), value=Value(headers=map[0:5.0 1:5.1], data=0), timeout=266345, tags=map[resonate:invoke:dst], createdOn=1000, completedOn=8000)))" err=<nil>
level=INFO msg=DST id=12285 t=998000|998999 req="PromiseSubscribe(awaited=p11, address=addr02)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p11, state=REJECTED, param=Value(headers=map[0:15.0], data=), value=Value(headers=map[0:2.0 1:2.1 2:2.2], data=0), timeout=944231, tags=map[resonate:invoke:dst], createdOn=0, completedOn=49000)))" err=<nil>
level=INFO msg=DST id=12288 t=999000|1000999 req="ScheduleGet(id=s13)" res="Response(status=20000, ScheduleGet(schedule=Schedule(id=s13, desc=, cron=58 * * * *, tags=map[], promiseId=s13.{{.timestamp}}, promiseTimeout=997996, promiseParam=Value(headers=map[0:16.0], data=), promiseTags=map[], lastRunTime=0, nextRunTime=3480000, createdOn=992000)))" err=<nil>
level=INFO msg=DST id=12292 t=999000|1000999 req="PromiseComplete(id=p01, state=RESOLVED, value=Value(headers=map[], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p01, state=REJECTED, param=Value(headers=map[], data=0), value=Value(headers=map[0:18.0], data=), timeout=898265, tags=map[0:4.0], createdOn=0, completedOn=27000)))" err=<nil>
level=INFO msg=DST id=12293 t=999000|1000999 req="PromiseComplete(id=p05, state=REJECTED, value=Value(headers=map[0:1.0 1:1.1 2:1.2], data=))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p05, state=REJECTED_CANCELED, param=Value(headers=map[0:6.0 1:6.1], data=0), value=Value(headers=map[], data=0), timeout=302215, tags=map[], createdOn=9000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12299 t=999000|1000999 req="CallbackCreate(id=__notify:p00:cb07, promiseId=p00, recv=\"dst\", mesg=Mesg(type=notify, root=p00, leaf=), timeout=999861)" res="Response(status=20000, CallbackCreate(promise=Promise(id=p00, state=RESOLVED, param=Value(headers=map[0:14.0 1:14.1], data=), value=Value(headers=map[], data=), timeout=922944, tags=map[resonate:invoke:dst], createdOn=2000, completedOn=8000), callback=<nil>))" err=<nil>
level=INFO msg=DST id=12300 t=999000|1000999 req="PromiseComplete(id=p15, state=REJECTED, value=Value(headers=map[], data=0))" res="Response(status=20000, PromiseComplete(promise=Promise(id=p15, state=REJECTED_CANCELED, param=Value(headers=map[0:10.0], data=), value=Value(headers=map[0:6.0 1:6.1], data=), timeout=775485, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true], createdOn=1000, completedOn=7000)))" err=<nil>
level=INFO msg=DST id=12301 t=999000|1000999 req="ScheduleGet(id=s05)" res="Response(status=40401, ScheduleGet(schedule=<nil>))" err=<nil>
level=INFO msg=DST id=12275 t=998000|1000999 req="ScheduleCreate(id=s09, desc=, cron=18 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=999791, promiseParam=Value(headers=map[], data=0), promiseTags=map[])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s09, desc=, cron=18 * * * *, tags=map[], promiseId=s09.{{.timestamp}}, promiseTimeout=999791, promiseParam=Value(headers=map[], data=0), promiseTags=map[], lastRunTime=0, nextRunTime=1080000, createdOn=999000)))" err=<nil>
level=INFO msg=DST id=12286 t=998000|1000999 req="ScheduleCreate(id=s04, desc=, cron=58 * * * *, tags=map[], promiseId=s04.{{.timestamp}}, promiseTimeout=998534, promiseParam=Value(headers=map[0:5.0 1:5.1], data=0), promiseTags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s04, desc=, cron=58 * * * *, tags=map[], promiseId=s04.{{.timestamp}}, promiseTimeout=998534, promiseParam=Value(headers=map[0:5.0 1:5.1], data=0), promiseTags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true], lastRunTime=0, nextRunTime=3480000, createdOn=999000)))" err=<nil>
level=INFO msg=DST id=12287 t=998000|1000999 req="ScheduleCreate(id=s01, desc=, cron=6 * * * *, tags=map[], promiseId=s01.{{.timestamp}}, promiseTimeout=998591, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:4.0])" res="Response(status=20100, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=6 * * * *, tags=map[], promiseId=s01.{{.timestamp}}, promiseTimeout=998591, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:4.0], lastRunTime=0, nextRunTime=3960000, createdOn=999000)))" err=<nil>
level=INFO msg=DST id=12289 t=999000|1000999 req="PromiseRegister(awaiter=p05, awaited=p12)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12290 t=999000|1000999 req="PromiseRegister(awaiter=p09, awaited=p00)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12294 t=999000|1000999 req="PromiseSubscribe(awaited=p07, address=addr00)" res="Response(status=20000, PromiseSubscribe(promise=Promise(id=p07, state=REJECTED_CANCELED, param=Value(headers=map[], data=), value=Value(headers=map[0:18.0], data=), timeout=694259, tags=map[resonate:invoke:dst], createdOn=0, completedOn=26000)))" err=<nil>
level=INFO msg=DST id=12295 t=999000|1000999 req="PromiseCreate(id=p06, param=Value(headers=map[0:10.0], data=), timeout=830442, tags=map[0:3.0 1:3.1 resonate:invoke:dst resonate:timeout:true])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p06, state=REJECTED_CANCELED, param=Value(headers=map[0:1.0 1:1.1 2:1.2], data=0), value=Value(headers=map[], data=0), timeout=844908, tags=map[resonate:invoke:dst], createdOn=4000, completedOn=23000)))" err=<nil>
level=INFO msg=DST id=12296 t=999000|1000999 req="PromiseRegister(awaiter=p17, awaited=p05)" res="Response(status=40404, PromiseRegister(promise=<nil>))" err=<nil>
level=INFO msg=DST id=12297 t=999000|1000999 req="PromiseCreate(id=p12, param=Value(headers=map[0:7.0 1:7.1 2:7.2], data=), timeout=865280, tags=map[])" res="Response(status=20000, PromiseCreate(promise=Promise(id=p12, state=REJECTED, param=Value(headers=map[], data=), value=Value(headers=map[0:19.0], data=), timeout=336057, tags=map[], createdOn=6000, completedOn=16000)))" err=<nil>
level=INFO msg=DST id=12298 t=999000|1000999 req="TaskCreate(promise=PromiseCreate(id=p14, param=Value(headers=map[0:6.0 1:6.1], data=0), timeout=848771, tags=map[0:5.0 resonate:invoke:dst resonate:timeout:true]), task=CreateTask(promiseId=p14, processId=p14, ttl=2000, timeout=848771))" res="Response(status=20000, TaskCreate(promise=Promise(id=p14, state=REJECTED, param=Value(headers=map[0:15.0], data=0), value=Value(headers=map[], data=0), timeout=215100, tags=map[0:4.0 resonate:invoke:dst], createdOn=2000, completedOn=5000), task=<nil>))" err=<nil>
level=INFO msg=DST id=12291 t=999000|1002999 req="ScheduleCreate(id=s01, desc=, cron=23 * * * *, tags=map[], promiseId=s01.{{.timestamp}}, promiseTimeout=999993, promiseParam=Value(headers=map[], data=), promiseTags=map[0:4.0])" res="Response(status=20000, ScheduleCreate(schedule=Schedule(id=s01, desc=, cron=6 * * * *, tags=map[], promiseId=s01.{{.timestamp}}, promiseTimeout=998591, promiseParam=Value(headers=map[], data=0), promiseTags=map[0:4.0], lastRunTime=0, nextRunTime=3960000, createdOn=999000)))" err=<nil>
level=ERROR msg="DST is non linearizable, run with -v flag for more information" v=false
Error: DST failed for seed='19770'

more details

[flossypurse]

Closing as part of a maintenance sweep — this appears to be an automated DST failure record. If this represents an active bug, please reopen with reproduction steps.

[flossypurse]

automated accidental close, reopening.