Re: kern/59339: heartbeat watchdog fires since 10.99.14

["Thomas Klausner via gnats" <gnats-admin%NetBSD.org@localhost>]

The following reply was made to PR kern/59339; it has been noted by GNATS.

From: Thomas Klausner <wiz%NetBSD.org@localhost>
To: gnats-bugs%netbsd.org@localhost
Cc: Taylor R Campbell <riastradh%NetBSD.org@localhost>
Subject: Re: kern/59339: heartbeat watchdog fires since 10.99.14
Date: Sun, 11 May 2025 22:38:22 +0200

 So I rebooted into a kernel with pr59339-itimercalloutassert-v5.patch
 yesterday, and it paniced this afternooon shortly after I started a
 bulk build.  Looking at var/log/messages I found one weird line from
 this morning:
 
 May 11 08:55:47 exadelic /netbsd: cks rounded to 2[clock 0] now=3D174691038=
 5.902206688, last=3D1746910385.882207038 + interval=3D0.010000000 -> next=
 =3D1746910385.902207038; delta=3D0.000000350 ticks rounded to 2[clock 0] no=
 w=3D1746910385.922206613, last=3D1746910385.902207038 + interval=3D0.010000=
 000 -> next=3D1746910385.922207038; delta=3D0.000000425 ticks rounded to 2[=
 clock 0] now=3D1746910385.942206438, last=3D1746910385.922207038 + interval=
 =3D0.010000000 -> next=3D1746910385.942207038; delta=3D0.000000600 ticks ro=
 unded to 2[clock 0] now=3D1746910385.962206343, last=3D1746910385.942207038=
  + interval=3D0.010000000 -> next=3D1746910385.962207038; delta=3D0.0000006=
 95 ticks rounded to 2[clock 0] now=3D1746910386.472204408, last=3D174691038=
 6.462204553 + interval=3D0.010000000 -> next=3D1746910386.472204553; delta=
 =3D0.000000145 ticks rounded to 2[clock 0] now=3D1746910386.502204526, last=
 =3D1746910386.472204553 + interval=3D0.010000000 -> next=3D1746910386.50220=
 4553; delta=3D0.000000027 ticks rounded to 2[clock 0] now=3D1746910386.5222=
 04241, last=3D1746910386.502204553 + interval=3D0.010000000 -> next=3D17469=
 10386.522204553; delta=3D0.000000312 ticks rounded to 2[clock 0] now=3D1746=
 910386.542203735, last=3D1746910386.522204553 + interval=3D0.010000000 -> n=
 ext=3D1746910386.542204553; delta=3D0.000000818 ticks rounded to 2[clock 0]=
  now=3D1746910386.562204231, last=3D1746910386.542204553 + interval=3D0.010=
 000000 -> next=3D1746910386.562204553; delta=3D0.000000322 ticks rounded to=
  2[clock 0] now=3D1746910386.582204146, last=3D1746910386.562204553 + inter=
 val=3D0.010000000 -> next=3D1746910386.582204553; delta=3D0.000000407 ticks=
  rounded to 2[clock 0] now=3D1746910386.602204010, last=3D1746910386.582204=
 553 + interval=3D0.010000000 -> next=3D1746910386.602204553; delta=3D0.0000=
 00543 ticks rounded to 2[clock 0] now=3D1746910386.622204025, last=3D174691=
 0386.602204553 + interval=3D0.010000000 -> next=3D1746910386.622204553; del=
 ta=3D0.000000528 ticks rounded to 2[clock 0] now=3D1746910387.052202191, la=
 st=3D1746910387.042202326 + interval=3D0.010000000 -> next=3D1746910387.052=
 202326; delta=3D0.000000135 ticks rounded to 2[clock 0] now=3D1746910387.07=
 2202116, last=3D1746910387.052202326 + interval=3D0.010000000 -> next=3D174=
 6910387.072202326; delta=3D0.000000210 ticks rounded to 2[clock 0] now=3D17=
 46910387.092202121, last=3D1746910387.072202326 + interval=3D0.010000000 ->=
  next=3D1746910387.092202326; delta=3D0.000000205 ticks rounded to 2[clock =
 0] now=3D1746910387.112202096, last=3D1746910387.092202326 + interval=3D0.0=
 10000000 -> next=3D1746910387.112202326; delta=3D0.000000230 ticks rounded =
 to 2[clock 0] now=3D1746910387.132201981, last=3D1746910387.112202326 + int=
 erval=3D0.010000000 -> next=3D1746910387.132202326; delta=3D0.000000345 tic=
 ks rounded to 2[clock 0] now=3D1746910387.152201905, last=3D1746910387.1322=
 02326 + interval=3D0.010000000 -> next=3D1746910387.152202326; delta=3D0.00=
 0000421 ticks rounded to 2[clock 0] now=3D1746910387.172201840, last=3D1746=
 910387.152202326 + interval=3D0.010000000 -> next=3D1746910387.172202326; d=
 elta=3D0.000000486 ticks rounded to 2[clock 0] now=3D1746910387.192201635, =
 last=3D1746910387.172202326 + interval=3D0.010000000 -> next=3D1746910387.1=
 92202326; delta=3D0.000000691 ticks rounded to 2[clock 0] now=3D1746910387.=
 212201680, last=3D1746910387.192202326 + interval=3D0.010000000 -> next=3D1=
 746910387.212202326; delta=3D0.000000646 ticks rounded to 2[clock 0] now=3D=
 1746910387.232201515, last=3D1746910387.212202326 + interval=3D0.010000000 =
 -> next=3D1746910387.232202326; delta=3D0.000000811 ticks rounded to 2[cloc=
 k 0] now=3D1746910388.292197515, last=3D1746910388.282197580 + interval=3D0=
 =2E010000000 -> next=3D1746910388.292197580; delta=3D0.000000065 ticks roun=
 ded to 2[clock 0] now=3D1746910388.312197550, last=3D1746910388.292197580 +=
  interval=3D0.010000000 -> next=3D1746910388.312197580; delta=3D0.000000030=
  ticks rounded to 2[clock 0] now=3D1746910388.332197394, last=3D1746910388.=
 312197580 + interval=3D0.010000000 -> next=3D1746910388.332197580; delta=3D=
 0.000000186 ticks rounded to 2[clock 0] now=3D1746910388.352197480, last=3D=
 1746910388.332197580 + interval=3D0.010000000 -> next=3D1746910388.35219758=
 0; delta=3D0.000000100 ticks rounded to 2[clock 0] now=3D1746910388.3721973=
 14, last=3D1746910388.352197580 + interval=3D0.010000000 -> next=3D17469103=
 88.372197580; delta=3D0.000000266 ticks rounded to 2[clock 0] now=3D1746910=
 388.392196879, last=3D1746910388.372197580 + interval=3D0.010000000 -> next=
 =3D1746910388.392197580; delta=3D0.000000701 ticks rounded to 2[clock 0] no=
 w=3D1746910388.412197174, last=3D1746910388.392197580 + interval=3D0.010000=
 000 -> next=3D1746910388.412197580; delta=3D0.000000406 ticks rounded to 2[=
 clock 0] now=3D1746910388.432197169, last=3D1746910388.412197580 + interval=
 =3D0.010000000 -> next=3D1746910388.432197580; delta=3D0.000000411 ticks ro=
 unded to 2[clock 0] now=3D1746910388.452197054, last=3D1746910388.432197580=
  + interval=3D0.010000000 -> next=3D1746910388.452197580; delta=3D0.0000005=
 26 ticks rounded to 2[clock 0] now=3D1746910388.472196939, last=3D174691038=
 8.452197580 + interval=3D0.010000000 -> next=3D1746910388.472197580; delta=
 =3D0.000000641 ticks rounded to 2[clock 0] now=3D1746910388.492196974, last=
 =3D1746910388.472197580 + interval=3D0.010000000 -> next=3D1746910388.49219=
 7580; delta=3D0.000000606 ticks rounded to 2[clock 0] now=3D1746910388.5321=
 96764, last=3D1746910388.512197580 + interval=3D0.010000000 -> next=3D17469=
 10388.532197580; delta=3D0.000000816 ticks rounded to 2[clock 0] now=3D1746=
 910388.552196728, last=3D1746910388.532197580 + interval=3D0.010000000 -> n=
 ext=3D1746910388.552197580; delta=3D0.000000852 ticks rounded to 2[clock 0]=
  now=3D1746910389.252194109, last=3D1746910389.252194147 + interval=3D0.010=
 000000 -> next=3D1746910389.252194147; delta=3D0.000000038 ticks rounded to=
  2[clock 0] now=3D1746910389.272193854, last=3D1746910389.252194147 + inter=
 val=3D0.010000000 -> next=3D1746910389.272194147; delta=3D0.000000293 ticks=
  rounded to 2[clock 0] now=3D1746910389.292193849, last=3D1746910389.272194=
 147 + interval=3D0.010000000 -> next=3D1746910389.292194147; delta=3D0.0000=
 00298 ticks rounded to 2[clock 0] now=3D1746910389.312193694, last=3D174691=
 0389.292194147 + interval=3D0.010000000 -> next=3D1746910389.312194147; del=
 ta=3D0.000000453 ticks rounded to 2[clock 0] now=3D1746910389.332193819, la=
 st=3D1746910389.312194147 + interval=3D0.010000000 -> next=3D1746910389.332=
 194147; delta=3D0.000000328 ticks rounded to 2[clock 0] now=3D1746910389.35=
 2193734, last=3D1746910389.332194147 + interval=3D0.010000000 -> next=3D174=
 6910389.352194147; delta=3D0.000000413 ticks rounded to 2[clock 0] now=3D17=
 46910389.392193473, last=3D1746910389.372194147 + interval=3D0.010000000 ->=
  next=3D1746910389.392194147; delta=3D0.000000674 ticks rounded to 2[clock =
 0] now=3D1746910389.412193418, last=3D1746910389.392194147 + interval=3D0.0=
 10000000 -> next=3D1746910389.412194147; delta=3D0.000000729 ticks rounded =
 to 2[clock 0] now=3D1746910389.432193323, last=3D1746910389.412194147 + int=
 erval=3D0.010000000 -> next=3D1746910389.432194147; delta=3D0.000000824 tic=
 ks rounded to 2[clock 0] now=3D1746910389.452193368, last=3D1746910389.4321=
 94147 + interval=3D0.010000000 -> next=3D1746910389.452194147; delta=3D0.00=
 0000779 ticks rounded to 2[clock 0] now=3D1746910389.472193323, last=3D1746=
 910389.452194147 + interval=3D0.010000000 -> next=3D1746910389.472194147; d=
 elta=3D0.000000824 ticks rounded to 2[clock 0] now=3D1746910391.552185369, =
 last=3D1746910391.542185429 + interval=3D0.010000000 -> next=3D1746910391.5=
 52185429; delta=3D0.000000060 ticks rounded to 2[clock 0] now=3D1746910391.=
 572185394, last=3D1746910391.552185429 + interval=3D0.010000000 -> next=3D1=
 746910391.572185429; delta=3D0.000000035 ticks rounded to 2[clock 0] now=3D=
 1746910391.592185269, last=3D1746910391.572185429 + interval=3D0.010000000 =
 -> next=3D1746910391.592185429; delta=3D0.000000160 ticks rounded to 2[cloc=
 k 0] now=3D1746910391.612185154, last=3D1746910391.592185429 + interval=3D0=
 =2E010000000 -> next=3D1746910391.612185429; delta=3D0.000000275 ticks roun=
 ded to 2[clock 0] now=3D1746910391.632185199, last=3D1746910391.612185429 +=
  interval=3D0.010000000 -> next=3D1746910391.632185429; delta=3D0.000000230=
  ticks rounded to 2[clock 0] now=3D1746910391.652185074, last=3D1746910391.=
 632185429 + interval=3D0.010000000 -> next=3D1746910391.652185429; delta=3D=
 0.000000355 ticks rounded to 2[clock 0] now=3D1746910391.672185189, last=3D=
 1746910391.652185429 + interval=3D0.010000000 -> next=3D1746910391.67218542=
 9; delta=3D0.000000240 ticks rounded to 2[clock 0] now=3D1746910391.6921849=
 53, last=3D1746910391.672185429 + interval=3D0.010000000 -> next=3D17469103=
 91.692185429; delta=3D0.000000476 ticks rounded to 2[clock 0] now=3D1746910=
 391.712184718, last=3D1746910391.692185429 + interval=3D0.010000000 -> next=
 =3D1746910391.712185429; delta=3D0.000000711 ticks rounded to 2[clock 0] no=
 w=3D1746910392.492181847, last=3D1746910392.482181852 + interval=3D0.010000=
 000 -> next=3D1746910392.492181852; delta=3D0.000000005 ticks rounded to 2[=
 clock 0] now=3D1746910392.512181802, last=3D1746910392.492181852 + interval=
 =3D0.010000000 -> next=3D1746910392.512181852; delta=3D0.000000050 ticks ro=
 unded to 2[clock 0] now=3D1746910392.532181707, last=3D1746910392.512181852=
  + interval=3D0.010000000 -> next=3D1746910392.532181852; delta=3D0.0000001=
 45 ticks rounded to 2[clock 0] now=3D1746910392.552181762, last=3D174691039=
 2.532181852 + interval=3D0.010000000 -> next=3D1746910392.552181852; delta=
 =3D0.000000090 ticks rounded to 2[clock 0] now=3D1746910392.572181556, last=
 =3D1746910392.552181852 + interval=3D0.010000000 -> next=3D1746910392.57218=
 1852; delta=3D0.000000296 ticks rounded to 2[clock 0] now=3D1746910392.5921=
 81431, last=3D1746910392.572181852 + interval=3D0.010000000 -> next=3D17469=
 10392.592181852; delta=3D0.000000421 ticks rounded to 2[clock 0] now=3D1746=
 910392.612181386, last=3D1746910392.592181852 + interval=3D0.010000000 -> n=
 ext=3D1746910392.612181852; delta=3D0.000000466 ticks rounded to 2[clock 0]=
  now=3D1746910392.632181381, last=3D1746910392.612181852 + interval=3D0.010=
 000000 -> next=3D1746910392.632181852; delta=3D0.000000471 ticks rounded to=
  2[clock 0] now=3D1746910392.652181196, last=3D1746910392.632181852 + inter=
 val=3D0.010000000 -> next=3D1746910392.652181852; delta=3D0.000000656 ticks=
  rounded to 2[clock 0] now=3D1746910393.282178998, last=3D1746910393.272179=
 026 + interval=3D0.010000000 -> next=3D1746910393.282179026; delta=3D0.0000=
 00028 ticks rounded to 2[clock 0] now=3D1746910393.302178773, last=3D174691=
 0393.282179026 + interval=3D0.010000000 -> next=3D1746910393.302179026; del=
 ta=3D0.000000253 ticks rounded to 2[clock 0] now=3D1746910393.322178928, la=
 st=3D1746910393.302179026 + interval=3D0.010000000 -> next=3D1746910393.322=
 179026; delta=3D0.000000098 ticks rounded to 2[clock 0] now=3D1746910393.34=
 2178893, last=3D1746910393.322179026 + interval=3D0.010000000 -> next=3D174=
 6910393.342179026; delta=3D0.000000133 ticks rounded to 2[clock 0] now=3D17=
 46910393.362178577, last=3D1746910393.342179026 + interval=3D0.010000000 ->=
  next=3D1746910393.362179026; delta=3D0.000000449 ticks rounded to 2[clock =
 0] now=3D1746910393.382178482, last=3D1746910393.362179026 + interval=3D0.0=
 10000000 -> next=3D1746910393.382179026; delta=3D0.000000544 ticks rounded =
 to 2[clock 0] now=3D1746910394.102175736, last=3D1746910394.102176034 + int=
 erval=3D0.010000000 -> next=3D1746910394.102176034; delta=3D0.000000298 tic=
 ks rounded to 2[clock 0] now=3D1746910394.122175781, last=3D1746910394.1021=
 76034 + interval=3D0.010000000 -> next=3D1746910394.122176034; delta=3D0.00=
 0000253 ticks rounded to 2[clock 0] now=3D1746910394.142175936, last=3D1746=
 910394.122176034 + interval=3D0.010000000 -> next=3D1746910394.142176034; d=
 elta=3D0.000000098 ticks rounded to 2[clock 0] now=3D1746910394.162175580, =
 last=3D1746910394.142176034 + interval=3D0.010000000 -> next=3D1746910394.1=
 62176034; delta=3D0.000000454 ticks rounded to 2[clock 0] now=3D1746910394.=
 182175495, last=3D1746910394.162176034 + interval=3D0.010000000 -> next=3D1=
 746910394.182176034; delta=3D0.000000539 ticks rounded to 2[clock 0] now=3D=
 1746910394.202175420, last=3D1746910394.182176034 + interval=3D0.010000000 =
 -> next=3D1746910394.202176034; delta=3D0.000000614 ticks rounded to 2[cloc=
 k 0] now=3D1746910394.222175365, last=3D1746910394.202176034 + interval=3D0=
 =2E010000000 -> next=3D1746910394.222176034; delta=3D0.000000669 ticks roun=
 ded to 2[clock 0] now=3D1746910394.242175240, last=3D1746910394.222176034 +=
  interval=3D0.010000000 -> next=3D1746910394.242176034; delta=3D0.000000794=
  ticks rounded to 2[clock 0] now=3D1746910394.262175185, last=3D1746910394.=
 242176034 + interval=3D0.010000000 -> next=3D1746910394.262176034; delta=3D=
 0.000000849 ticks rounded to 2[clock 0] now=3D1746910394.282175150, last=3D=
 1746910394.262176034 + interval=3D0.010000000 -> next=3D1746910394.28217603=
 4; delta=3D0.000000884 ticks rounded to 2[clock 0] now=3D1746910394.3621748=
 39, last=3D1746910394.352175014 + interval=3D0.010000000 -> next=3D17469103=
 94.362175014; delta=3D0.000000175 ticks rounded to 2[clock 0] now=3D1746910=
 394.382174774, last=3D1746910394.372174839 + interval=3D0.010000000 -> next=
 =3D1746910394.382174839; delta=3D0.000000065 ticks rounded to 2[clock 0] no=
 w=3D1746910395.172171864, last=3D1746910395.162171999 + interval=3D0.010000=
 000 -> next=3D1746910395.172171999; delta=3D0.000000135 ticks rounded to 2[=
 clock 0] now=3D1746910395.192171668, last=3D1746910395.172171999 + interval=
 =3D0.010000000 -> next=3D1746910395.192171999; delta=3D0.000000331 ticks ro=
 unded to 2[clock 0] now=3D1746910395.212171693, last=3D1746910395.192171999=
  + interval=3D0.010000000 -> next=3D1746910395.212171999; delta=3D0.0000003=
 06 ticks rounded to 2[clock 0] now=3D1746910395.232171348, last=3D174691039=
 5.212171999 + interval=3D0.010000000 -> next=3D1746910395.232171999; delta=
 =3D0.000000651 ticks rounded to 2[clock 0] now=3D1746910395.252171142, last=
 =3D1746910395.232171999 + interval=3D0.010000000 -> next=3D1746910395.25217=
 1999; delta=3D0.000000857 ticks rounded to 2[clock 0] now=3D1746910395.2721=
 71388, last=3D1746910395.252171999 + interval=3D0.010000000 -> next=3D17469=
 10395.272171999; delta=3D0.000000611 ticks rounded to 2[clock 0] now=3D1746=
 910395.292171403, last=3D1746910395.272171999 + interval=3D0.010000000 -> n=
 ext=3D1746910395.292171999; delta=3D0.000000596 ticks rounded to 2[clock 0]=
  now=3D1746910395.312171337, last=3D1746910395.292171999 + interval=3D0.010=
 000000 -> next=3D1746910395.312171999; delta=3D0.000000662 ticks rounded to=
  2[clock 0] now=3D1746910395.332171202, last=3D1746910395.312171999 + inter=
 val=3D0.010000000 -> next=3D1746910395.332171999; delta=3D0.000000797 ticks=
  rounded to 2[clock 0] now=3D1746910395.352171107, last=3D1746910395.332171=
 999 + interval=3D0.010000000 -> next=3D1746910395.352171999; delta=3D0.0000=
 00892 ticks rounded to 2[clock 0] now=3D1746910395.372171012, last=3D174691=
 0395.352171999 + interval=3D0.010000000 -> next=3D1746910395.372171999; del=
 ta=3D0.000000987 ticks rounded to 2[clock 0] now=3D1746910395.412170951, la=
 st=3D1746910395.402170957 + interval=3D0.010000000 -> next=3D1746910395.412=
 170957; delta=3D0.000000006 ticks rounded to 2[clock 0] now=3D1746910395.45=
 2170290, last=3D1746910395.442170957 + interval=3D0.010000000 -> next=3D174=
 6910395.452170957; delta=3D0.000000667 ticks rounded to 2[clock 0] now=3D17=
 46910395.472170626, last=3D1746910395.452170957 + interval=3D0.010000000 ->=
  next=3D1746910395.472170957; delta=3D0.000000331 ticks rounded to 2[clock =
 0] now=3D1746910395.492170550, last=3D1746910395.472170957 + interval=3D0.0=
 10000000 -> next=3D1746910395.492170957; delta=3D0.000000407 ticks rounded =
 to 2[clock 0] now=3D1746910395.512170626, last=3D1746910395.492170957 + int=
 erval=3D0.010000000 -> next=3D1746910395.512170957; delta=3D0.000000331 tic=
 ks rounded to 2[clock 0] now=3D1746910395.532169969, last=3D1746910395.5121=
 70957 + interval=3D0.010000000 -> next=3D1746910395.532170957; delta=3D0.00=
 0000988 ticks rounded to 2[clock 0] now=3D1746910395.552170435, last=3D1746=
 910395.532170957 + interval=3D0.010000000 -> next=3D1746910395.552170957; d=
 elta=3D0.000000522 ticks rounded to 2[clock 0] now=3D1746910395.572170270, =
 last=3D1746910395.552170957 + interval=3D0.010000000 -> next=3D1746910395.5=
 72170957; delta=3D0.000000687 ticks rounded to 2[clock 0] now=3D1746910395.=
 592170114, last=3D1746910395.572170957 + interval=3D0.010000000 -> next=3D1=
 746910395.592170957; delta=3D0.000000843 ticks rounded to 2[clock 0] now=3D=
 1746910395.822169400, last=3D1746910395.812169500 + interval=3D0.010000000 =
 -> next=3D1746910395.822169500; delta=3D0.000000100 ticks rounded to 2[cloc=
 k 0] now=3D1746910395.842169355, last=3D1746910395.822169500 + interval=3D0=
 =2E010000000 -> next=3D1746910395.842169500; delta=3D0.000000145 ticks roun=
 ded to 2[clock 0] now=3D1746910395.862169259, last=3D1746910395.842169500 +=
  interval=3D0.010000000 -> next=3D1746910395.862169500; delta=3D0.000000241=
  ticks rounded to 2[clock 0] now=3D1746910395.882169094, last=3D1746910395.=
 862169500 + interval=3D0.010000000 -> next=3D1746910395.882169500; delta=3D=
 0.000000406 ticks rounded to 2[clock 0] now=3D1746910395.902169099, last=3D=
 1746910395.882169500 + interval=3D0.010000000 -> next=3D1746910395.90216950=
 0; delta=3D0.000000401 ticks rounded to 2[clock 0] now=3D1746910395.9221691=
 84, last=3D1746910395.902169500 + interval=3D0.010000000 -> next=3D17469103=
 95.922169500; delta=3D0.000000316 ticks rounded to 2[clock 0] now=3D1746910=
 395.9
 
 and then later the panic line for this afternoon:
 May 11 14:21:05 exadelic savecore: reboot after panic: panic: kernel diagno=
 stic assertion "*timo > 0" failed: file "/usr/src/sys/kern/subr_time.c", li=
 ne 261=20
 
 (gdb) target kvm netbsd.16.core
 0xffffffff80239b85 in cpu_reboot (howto=3Dhowto@entry=3D260, bootstr=3Dboot=
 str@entry=3D0x0) at /usr/src/sys/arch/amd64/amd64/machdep.c:709
 warning: 709    /usr/src/sys/arch/amd64/amd64/machdep.c: No such file or di=
 rectory
 (gdb) bt
 #0  0xffffffff80239b85 in cpu_reboot (howto=3Dhowto@entry=3D260, bootstr=3D=
 bootstr@entry=3D0x0) at /usr/src/sys/arch/amd64/amd64/machdep.c:709
 #1  0xffffffff80de3b15 in kern_reboot (howto=3Dhowto@entry=3D260, bootstr=
 =3Dbootstr@entry=3D0x0) at /usr/src/sys/kern/kern_reboot.c:91
 #2  0xffffffff80e29be3 in vpanic (fmt=3D0xffffffff81427440 "kernel %sassert=
 ion \"%s\" failed: file \"%s\", line %d ", ap=3Dap@entry=3D0xffff85a4b2730e=
 48) at /usr/src/sys/kern/subr_prf.c:288
 #3  0xffffffff80ff848c in kern_assert (fmt=3Dfmt@entry=3D0xffffffff81427440=
  "kernel %sassertion \"%s\" failed: file \"%s\", line %d ") at /usr/src/sys=
 /lib/libkern/kern_assert.c:51
 #4  0xffffffff80e2c0fd in ts2timo (clock_id=3Dclock_id@entry=3D3, flags=3Df=
 lags@entry=3D0, ts=3Dts@entry=3D0xffff85a4b2730f70, timo=3Dtimo@entry=3D0xf=
 fff85a4b2730eec, start=3Dstart@entry=3D0xffff85a4b2730ef0)
     at /usr/src/sys/kern/subr_time.c:261
 #5  0xffffffff80dffb54 in nanosleep1 (l=3Dl@entry=3D0xffff80851713a800, clo=
 ck_id=3Dclock_id@entry=3D3, flags=3Dflags@entry=3D0, rqt=3Drqt@entry=3D0xff=
 ff85a4b2730f70, rmt=3D0xffff85a4b2730f60)
     at /usr/src/sys/kern/kern_time.c:420
 #6  0xffffffff80dffdbb in sys___nanosleep50 (l=3D0xffff80851713a800, uap=3D=
 0xffff85a4b2731000, retval=3D<optimized out>) at /usr/src/sys/kern/kern_tim=
 e.c:373
 #7  0xffffffff805b7cc1 in sy_call (rval=3D0xffff85a4b2730fb0, uap=3D0xffff8=
 5a4b2731000, l=3D0xffff80851713a800, sy=3D0xffffffff8188a3d0 <sysent+10320>=
 ) at /usr/src/sys/sys/syscallvar.h:65
 #8  sy_invoke (code=3D430, rval=3D0xffff85a4b2730fb0, uap=3D0xffff85a4b2731=
 000, l=3D0xffff80851713a800, sy=3D0xffffffff8188a3d0 <sysent+10320>) at /us=
 r/src/sys/sys/syscallvar.h:94
 #9  syscall (frame=3D0xffff85a4b2731000) at /usr/src/sys/arch/x86/x86/sysca=
 ll.c:137
 #10 0xffffffff8021025d in handle_syscall ()
 (gdb) fr 4
 #4  0xffffffff80e2c0fd in ts2timo (clock_id=3Dclock_id@entry=3D3, flags=3Df=
 lags@entry=3D0, ts=3Dts@entry=3D0xffff85a4b2730f70, timo=3Dtimo@entry=3D0xf=
 fff85a4b2730eec, start=3Dstart@entry=3D0xffff85a4b2730ef0)
     at /usr/src/sys/kern/subr_time.c:261
 warning: 261    /usr/src/sys/kern/subr_time.c: No such file or directory
 (gdb) p *ts
 $1 =3D {tv_sec =3D 9223372036854775807, tv_nsec =3D 999999999}
 (gdb) p *timo
 $2 =3D 0
 (gdb) p *start
 $3 =3D {tv_sec =3D 81605, tv_nsec =3D 753968635}
 (gdb)
 
  Thomas