Sun Nov 27 12:19:28.319 2005: main: opening map file map
index 0: node 100: 0.000000,0.000000,0.000000,0.000000
index 1: node 103: 0.000000,21.000000,-0.500000,0.000000
index 2: node 102: 0.000000,35.000000,-2.000000,0.000000
index 3: node 108: 16.900000,35.000000,-2.000000,0.000000
index 4: node 105: 16.900000,23.100000,0.000000,0.000000
index 5: node 104: 26.799999,35.000000,-1.000000,0.000000
index 6: node 110: 16.900000,51.299999,-2.500000,0.000000
index 7: node 111: 5.800000,53.049999,-0.500000,0.000000
index 8: node 106: 5.800000,61.150002,1.500000,0.000000
index 9: node 109: -3.850000,54.549999,0.500000,0.000000
Sun Nov 27 12:19:28.369 2005: main: opening list file /tmp/systestfile-949164800.157251
read expt record: 6920 0.000000 0.000000 0.000000 22.000000 60.000000 OK,949164816.502195
read expt record: 6921 0.000000 0.000000 0.000000 22.000000 60.000000 OK,949164861.430207
read expt record: 6922 0.000000 0.000000 0.000000 22.000000 60.000000 OK,949164906.292002
read expt record: 6923 0.000000 0.000000 0.000000 22.000000 60.000000 OK,949164951.475735
read expt record: 6924 0.000000 0.000000 0.000000 22.000000 60.000000 OK,949164996.412188
read expt record: 6099 0.000000 35.000000 -2.000000 22.000000 60.000000 OK,949164810.815454
read expt record: 6100 0.000000 35.000000 -2.000000 22.000000 60.000000 OK,949164822.499165
read expt record: 6101 0.000000 35.000000 -2.000000 22.000000 60.000000 OK,949164867.666678
read expt record: 6102 0.000000 35.000000 -2.000000 22.000000 60.000000 OK,949164912.584561
read expt record: 6103 0.000000 35.000000 -2.000000 22.000000 60.000000 OK,949164957.350697
read expt record: 2642 0.000000 21.000000 -0.500000 22.000000 60.000000 OK,949164825.338281
read expt record: 2643 0.000000 21.000000 -0.500000 22.000000 60.000000 OK,949164870.428938
read expt record: 2644 0.000000 21.000000 -0.500000 22.000000 60.000000 OK,949164915.345159
read expt record: 2645 0.000000 21.000000 -0.500000 22.000000 60.000000 OK,949164960.369272
read expt record: 2646 0.000000 21.000000 -0.500000 22.000000 60.000000 OK,949165005.361332
read expt record: 9278 26.799999 35.000000 -1.000000 22.000000 60.000000 OK,949164828.311734
read expt record: 9279 26.799999 35.000000 -1.000000 22.000000 60.000000 OK,949164873.633941
read expt record: 9280 26.799999 35.000000 -1.000000 22.000000 60.000000 OK,949164918.469376
read expt record: 9281 26.799999 35.000000 -1.000000 22.000000 60.000000 OK,949164964.503820
read expt record: 9282 26.799999 35.000000 -1.000000 22.000000 60.000000 OK,949165008.822939
read expt record: 7345 16.900000 23.100000 0.000000 22.000000 60.000000 OK,949164831.330216
read expt record: 7346 16.900000 23.100000 0.000000 22.000000 60.000000 OK,949164876.496016
read expt record: 7347 16.900000 23.100000 0.000000 22.000000 60.000000 OK,949164921.417617
read expt record: 7348 16.900000 23.100000 0.000000 22.000000 60.000000 OK,949164966.608637
read expt record: 7349 16.900000 23.100000 0.000000 22.000000 60.000000 OK,949165011.716870
read expt record: 2297 5.800000 61.150002 1.500000 22.000000 60.000000 OK,
read expt record: 2298 5.800000 61.150002 1.500000 22.000000 60.000000 OK,
read expt record: 2299 5.800000 61.150002 1.500000 22.000000 60.000000 OK,
read expt record: 2300 5.800000 61.150002 1.500000 22.000000 60.000000 OK,
read expt record: 2301 5.800000 61.150002 1.500000 22.000000 60.000000 OK,
read expt record: 3633 16.900000 35.000000 -2.000000 22.000000 60.000000 OK,949164841.255986
read expt record: 3634 16.900000 35.000000 -2.000000 22.000000 60.000000 OK,949164885.713610
read expt record: 3635 16.900000 35.000000 -2.000000 22.000000 60.000000 OK,949164930.308127
read expt record: 3636 16.900000 35.000000 -2.000000 22.000000 60.000000 OK,949164975.776319
read expt record: 3637 16.900000 35.000000 -2.000000 22.000000 60.000000 OK,949165020.355353
read expt record: 3992 -3.850000 54.549999 0.500000 22.000000 60.000000 OK,949164843.296429
read expt record: 3993 -3.850000 54.549999 0.500000 22.000000 60.000000 OK,949164888.356062
read expt record: 3994 -3.850000 54.549999 0.500000 22.000000 60.000000 OK,949164933.311298
read expt record: 3995 -3.850000 54.549999 0.500000 22.000000 60.000000 OK,949164978.441351
read expt record: 3996 -3.850000 54.549999 0.500000 22.000000 60.000000 OK,949165023.328272
Sun Nov 27 12:19:28.388 2005: main: stopping.. status=-1
Sun Nov 27 12:19:28.388 2005: process_file: **** Processing file ar-raw-6920-100-100:
Sun Nov 27 12:19:28.404 2005: process_file: **** Orig dist was 326.250000 
Sun Nov 27 12:19:28.405 2005: process_file: **** Timing error was 4.795832 
Sun Nov 27 12:19:28.405 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8192.00, frac=0.70
Sun Nov 27 12:19:28.422 2005: ar_process_chirp: subsample ifft'd local recording
Sun Nov 27 12:19:28.422 2005: ar_process_chirp: ***Selfrange average = 6388.510254, frac over = 126.379784
Sun Nov 27 12:19:28.422 2005: ar_process_chirp: Final answer: 331.88[conf=126.379784], max value=807378.562500
Sun Nov 27 12:19:28.422 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:28.422 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:28.422 2005: process_file: node 100 Recorded distance of 1.688000 [126.300000] from node 0.0.0.100
Sun Nov 27 12:19:28.422 2005: main: **** OFFSET=5!!!
Sun Nov 27 12:19:28.422 2005: process_file: **** Processing file ar-raw-6920-100-103:
Sun Nov 27 12:19:28.444 2005: process_file: **** Timing error was 5.692100 
Sun Nov 27 12:19:28.444 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8191.95, frac=0.70
Sun Nov 27 12:19:28.481 2005: ar_find_max: Initial mean/stddev: 70.913933/56.867813 (thresh=100)
Sun Nov 27 12:19:28.481 2005: ar_find_max: tracing, index 3095 sig=-1718.849854 m/s=104.435257/110.891563
Sun Nov 27 12:19:28.481 2005: ar_find_max:   Max conf is 14.56 (stddev=110.89)
Sun Nov 27 12:19:28.481 2005: ar_find_doa2: Found peak of 1718.849854[15.500276] at 3095, channel 0
Sun Nov 27 12:19:28.481 2005: ar_find_max: Initial mean/stddev: 112.571121/85.125023 (thresh=100)
Sun Nov 27 12:19:28.482 2005: ar_find_max: tracing, index 3083 sig=-2724.927734 m/s=145.396347/146.655563
Sun Nov 27 12:19:28.482 2005: ar_find_max:   Max conf is 17.59 (stddev=146.66)
Sun Nov 27 12:19:28.482 2005: ar_find_doa2: Found peak of 2724.927734[18.580459] at 3083, channel 1
Sun Nov 27 12:19:28.482 2005: ar_find_max: Initial mean/stddev: 154.180847/105.857391 (thresh=100)
Sun Nov 27 12:19:28.482 2005: ar_find_max: tracing, index 3083 sig=-4461.989258 m/s=262.989563/320.528534
Sun Nov 27 12:19:28.482 2005: ar_find_max: tracing, index 3084 sig=4897.736816 m/s=262.989563/320.528534
Sun Nov 27 12:19:28.482 2005: ar_find_max: tracing, index 3085 sig=7952.583984 m/s=262.989563/320.528534
Sun Nov 27 12:19:28.482 2005: ar_find_max:   Max conf is 23.99 (stddev=320.53)
Sun Nov 27 12:19:28.482 2005: ar_find_doa2: Found peak of 7952.583984[24.810846] at 3085, channel 2
Sun Nov 27 12:19:28.482 2005: ar_find_max: Initial mean/stddev: 98.982109/67.651215 (thresh=100)
Sun Nov 27 12:19:28.482 2005: ar_find_max: tracing, index 3095 sig=-3069.959473 m/s=145.858826/157.028458
Sun Nov 27 12:19:28.482 2005: ar_find_max:   Max conf is 18.62 (stddev=157.03)
Sun Nov 27 12:19:28.482 2005: ar_find_doa2: Found peak of 3069.959473[19.550338] at 3095, channel 3
Sun Nov 27 12:19:28.487 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:28.491 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:28.495 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:28.499 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:28.499 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.501 2005: do_lag: lag 0x1 = 11.8 (11101.030273)
Sun Nov 27 12:19:28.501 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:28.501 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:28.504 2005: do_lag: lag 0x2 = 12.5 (11846.033203)
Sun Nov 27 12:19:28.504 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:28.504 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.505 2005: do_lag: lag 0x3 = 0.2 (12414.189453)
Sun Nov 27 12:19:28.505 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:28.505 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.508 2005: do_lag: lag 1x2 = 0.8 (13340.724609)
Sun Nov 27 12:19:28.508 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:28.508 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:28.510 2005: do_lag: lag 1x3 = -11.5 (13004.844727)
Sun Nov 27 12:19:28.510 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:28.510 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.512 2005: do_lag: lag 2x3 = -12.2 (14224.137695)
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=16.045387
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=91.22, phi=1.58, speed=0.006804
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: final offsets are -5.763926, 5.523308, 6.310427, -5.523308
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: correcting for delta of 0.36...
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: correcting for delta of 0.20...
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: correcting for delta of -0.24...
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: correcting for delta of -0.14...
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: correcting for delta of 0.10...
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: correcting for delta of -0.07...
Sun Nov 27 12:19:28.512 2005: ar_find_doa2: Found crossing point at index 321 (i.e. 3091.12), conf=23.081430
Sun Nov 27 12:19:28.512 2005: ar_process_chirp: Theta = 91.221230 degrees, phi = 1.584451 degrees, SNR = 0.623232
Sun Nov 27 12:19:28.513 2005: ar_process_chirp: Final answer: 3091.12[conf=23.081430], max value=43791.886719
Sun Nov 27 12:19:28.518 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:28.518 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:28.518 2005: process_file: node 0 Recorded distance of 21.602000 [23.000000] from node 0.0.0.100
Sun Nov 27 12:19:28.518 2005: process_file: **** Processing file ar-raw-6920-100-102:
Sun Nov 27 12:19:28.543 2005: process_file: **** Timing error was 4.795832 
Sun Nov 27 12:19:28.543 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8191.90, frac=0.65
Sun Nov 27 12:19:28.579 2005: ar_find_max: Initial mean/stddev: 31.026321/23.956720 (thresh=100)
Sun Nov 27 12:19:28.580 2005: ar_find_max: tracing, index 5087 sig=979.661499 m/s=58.841904/68.812019
Sun Nov 27 12:19:28.580 2005: ar_find_max: tracing, index 5088 sig=1027.334961 m/s=58.841904/68.812019
Sun Nov 27 12:19:28.580 2005: ar_find_max:   Max conf is 14.07 (stddev=68.81)
Sun Nov 27 12:19:28.580 2005: ar_find_doa2: Found peak of 1027.334961[14.929586] at 5088, channel 0
Sun Nov 27 12:19:28.580 2005: ar_find_max: Initial mean/stddev: 41.555489/29.633041 (thresh=100)
Sun Nov 27 12:19:28.580 2005: ar_find_max: tracing, index 5075 sig=1785.367920 m/s=78.835785/108.457169
Sun Nov 27 12:19:28.580 2005: ar_find_max:   Max conf is 15.73 (stddev=108.46)
Sun Nov 27 12:19:28.580 2005: ar_find_doa2: Found peak of 1785.367920[16.461502] at 5075, channel 1
Sun Nov 27 12:19:28.580 2005: ar_find_max: Initial mean/stddev: 46.025135/31.917919 (thresh=100)
Sun Nov 27 12:19:28.581 2005: ar_find_max: tracing, index 5072 sig=1641.190308 m/s=84.894295/109.806900
Sun Nov 27 12:19:28.581 2005: ar_find_max: tracing, index 5073 sig=1888.618896 m/s=84.894295/109.806900
Sun Nov 27 12:19:28.581 2005: ar_find_max:   Max conf is 16.43 (stddev=109.81)
Sun Nov 27 12:19:28.581 2005: ar_find_doa2: Found peak of 1888.618896[17.199456] at 5073, channel 2
Sun Nov 27 12:19:28.581 2005: ar_find_max: Initial mean/stddev: 41.050705/31.601469 (thresh=100)
Sun Nov 27 12:19:28.582 2005: ar_find_max: tracing, index 5088 sig=-1256.759766 m/s=80.436935/87.553596
Sun Nov 27 12:19:28.582 2005: ar_find_max:   Max conf is 13.44 (stddev=87.55)
Sun Nov 27 12:19:28.582 2005: ar_find_doa2: Found peak of 1256.759766[14.354176] at 5088, channel 3
Sun Nov 27 12:19:28.586 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:28.590 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:28.595 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:28.599 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:28.599 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.600 2005: do_lag: lag 0x1 = 12.0 (1920.263062)
Sun Nov 27 12:19:28.600 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:28.600 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:28.603 2005: do_lag: lag 0x2 = 15.1 (2013.190063)
Sun Nov 27 12:19:28.603 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:28.603 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.605 2005: do_lag: lag 0x3 = -3.6 (1595.325439)
Sun Nov 27 12:19:28.605 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:28.605 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.607 2005: do_lag: lag 1x2 = 3.0 (2460.351562)
Sun Nov 27 12:19:28.607 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:28.607 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:28.609 2005: do_lag: lag 1x3 = -15.6 (1808.175293)
Sun Nov 27 12:19:28.609 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:28.609 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.611 2005: do_lag: lag 2x3 = -18.6 (1848.603027)
Sun Nov 27 12:19:28.611 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:28.611 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=15.023470
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=73.36, phi=16.89, speed=0.006096
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: final offsets are -3.630494, 6.724360, 9.371471, -6.724360
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: correcting for delta of -0.34...
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: correcting for delta of -1.47...
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: correcting for delta of -1.22...
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: correcting for delta of 0.84...
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: correcting for delta of 1.03...
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: correcting for delta of 0.38...
Sun Nov 27 12:19:28.612 2005: ar_find_doa2: Found crossing point at index 337 (i.e. 5083.12), conf=21.663025
Sun Nov 27 12:19:28.612 2005: ar_process_chirp: Theta = 73.364685 degrees, phi = 16.885864 degrees, SNR = 0.665625
Sun Nov 27 12:19:28.612 2005: ar_process_chirp: Final answer: 5083.12[conf=21.663025], max value=17208.550781
Sun Nov 27 12:19:28.620 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:28.620 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:28.620 2005: process_file: node 0 Recorded distance of 35.978000 [21.600000] from node 0.0.0.100
Sun Nov 27 12:19:28.620 2005: process_file: **** Processing file ar-raw-6920-100-108:
Sun Nov 27 12:19:28.647 2005: process_file: **** Timing error was 5.899152 
Sun Nov 27 12:19:28.647 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8191.95, frac=0.45
Sun Nov 27 12:19:28.682 2005: ar_find_max: Initial mean/stddev: 6.759219/4.615821 (thresh=100)
Sun Nov 27 12:19:28.683 2005: ar_find_max: tracing, index 5679 sig=175.254913 m/s=13.995068/10.206873
Sun Nov 27 12:19:28.683 2005: ar_find_max: tracing, index 5680 sig=254.314865 m/s=13.995068/10.206873
Sun Nov 27 12:19:28.683 2005: ar_find_max:   Max conf is 23.54 (stddev=10.21)
Sun Nov 27 12:19:28.683 2005: ar_find_doa2: Found peak of 254.314865[24.916041] at 5680, channel 0
Sun Nov 27 12:19:28.683 2005: ar_find_max: Initial mean/stddev: 2.201864/1.944307 (thresh=100)
Sun Nov 27 12:19:28.684 2005: ar_find_max: tracing, index 5669 sig=72.981735 m/s=4.700403/3.666153
Sun Nov 27 12:19:28.684 2005: ar_find_max:   Max conf is 18.62 (stddev=3.67)
Sun Nov 27 12:19:28.684 2005: ar_find_doa2: Found peak of 72.981735[19.906899] at 5669, channel 1
Sun Nov 27 12:19:28.684 2005: ar_find_max: Initial mean/stddev: 11.258770/8.503304 (thresh=100)
Sun Nov 27 12:19:28.685 2005: ar_find_max: tracing, index 5672 sig=232.194641 m/s=15.716620/16.057627
Sun Nov 27 12:19:28.685 2005: ar_find_max: tracing, index 5673 sig=250.019211 m/s=15.716620/16.057627
Sun Nov 27 12:19:28.685 2005: ar_find_max:   Max conf is 14.59 (stddev=16.06)
Sun Nov 27 12:19:28.685 2005: ar_find_doa2: Found peak of 250.019211[15.570122] at 5673, channel 2
Sun Nov 27 12:19:28.685 2005: ar_find_max: Initial mean/stddev: 10.228427/6.375807 (thresh=100)
Sun Nov 27 12:19:28.687 2005: ar_find_max:   Max conf is 10.23 (stddev=6.10)
Sun Nov 27 12:19:28.691 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:28.695 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:28.700 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:28.704 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:28.704 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.705 2005: do_lag: lag 0x1 = 10.5 (16.691488)
Sun Nov 27 12:19:28.705 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:28.705 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:28.708 2005: do_lag: lag 0x2 = 6.2 (16.498766)
Sun Nov 27 12:19:28.708 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:28.708 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.710 2005: do_lag: lag 0x3 = -4.9 (12.200814)
Sun Nov 27 12:19:28.710 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:28.710 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.712 2005: do_lag: lag 1x2 = -3.9 (22.824978)
Sun Nov 27 12:19:28.712 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:28.712 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:28.714 2005: do_lag: lag 1x3 = -15.5 (11.850707)
Sun Nov 27 12:19:28.714 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:28.714 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.716 2005: do_lag: lag 2x3 = -11.9 (12.445253)
Sun Nov 27 12:19:28.716 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:28.716 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=8.457502
Sun Nov 27 12:19:28.716 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=63.85, phi=3.49, speed=0.006881
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: final offsets are -2.574816, 7.544008, 3.779158, -7.544008
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: correcting for delta of -0.21...
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: correcting for delta of 0.11...
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: correcting for delta of -0.27...
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: correcting for delta of -0.21...
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: correcting for delta of 0.24...
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: correcting for delta of 0.09...
Sun Nov 27 12:19:28.717 2005: ar_find_doa2: Found crossing point at index 321 (i.e. 5677.12), conf=9.484035
Sun Nov 27 12:19:28.717 2005: ar_process_chirp: Theta = 63.845085 degrees, phi = 3.493425 degrees, SNR = 1.182382
Sun Nov 27 12:19:28.717 2005: ar_process_chirp: Final answer: 5677.12[conf=9.484035], max value=1570.867432
Sun Nov 27 12:19:28.725 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:28.725 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:28.725 2005: process_file: node 0 Recorded distance of 40.267000 [9.400000] from node 0.0.0.100
Sun Nov 27 12:19:28.725 2005: process_file: **** Processing file ar-raw-6920-100-105:
Sun Nov 27 12:19:28.743 2005: process_file: **** Timing error was 4.898980 
Sun Nov 27 12:19:28.743 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8192.05, frac=0.80
Sun Nov 27 12:19:28.777 2005: ar_find_max: Initial mean/stddev: 27.897085/17.735580 (thresh=100)
Sun Nov 27 12:19:28.777 2005: ar_find_max: tracing, index 4299 sig=1328.282837 m/s=54.890678/58.097607
Sun Nov 27 12:19:28.777 2005: ar_find_max: tracing, index 4300 sig=1491.629883 m/s=54.890678/58.097607
Sun Nov 27 12:19:28.777 2005: ar_find_max:   Max conf is 24.73 (stddev=58.10)
Sun Nov 27 12:19:28.777 2005: ar_find_doa2: Found peak of 1491.629883[25.674550] at 4300, channel 0
Sun Nov 27 12:19:28.777 2005: ar_find_max: Initial mean/stddev: 27.141447/22.174046 (thresh=100)
Sun Nov 27 12:19:28.780 2005: ar_find_max: tracing, index 4288 sig=1929.873779 m/s=71.703522/80.771461
Sun Nov 27 12:19:28.780 2005: ar_find_max:   Max conf is 23.01 (stddev=80.77)
Sun Nov 27 12:19:28.780 2005: ar_find_doa2: Found peak of 1929.873779[23.893015] at 4288, channel 1
Sun Nov 27 12:19:28.780 2005: ar_find_max: Initial mean/stddev: 32.728897/23.651045 (thresh=100)
Sun Nov 27 12:19:28.780 2005: ar_find_max: tracing, index 4293 sig=1472.584961 m/s=64.914673/82.356575
Sun Nov 27 12:19:28.780 2005: ar_find_max: tracing, index 4294 sig=2321.914795 m/s=64.914673/82.356575
Sun Nov 27 12:19:28.780 2005: ar_find_max:   Max conf is 27.41 (stddev=82.36)
Sun Nov 27 12:19:28.780 2005: ar_find_doa2: Found peak of 2321.914795[28.193436] at 4294, channel 2
Sun Nov 27 12:19:28.780 2005: ar_find_max: Initial mean/stddev: 27.584593/20.030647 (thresh=100)
Sun Nov 27 12:19:28.781 2005: ar_find_max: tracing, index 4303 sig=1247.447754 m/s=50.337032/53.044876
Sun Nov 27 12:19:28.781 2005: ar_find_max: tracing, index 4304 sig=1558.888428 m/s=50.337032/53.044876
Sun Nov 27 12:19:28.781 2005: ar_find_max:   Max conf is 28.44 (stddev=53.04)
Sun Nov 27 12:19:28.781 2005: ar_find_doa2: Found peak of 1558.888428[29.388106] at 4304, channel 3
Sun Nov 27 12:19:28.785 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:28.789 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:28.794 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:28.798 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:28.798 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.799 2005: do_lag: lag 0x1 = 11.2 (1007.025940)
Sun Nov 27 12:19:28.799 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:28.799 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:28.802 2005: do_lag: lag 0x2 = 5.9 (1002.936584)
Sun Nov 27 12:19:28.802 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:28.802 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.803 2005: do_lag: lag 0x3 = -4.0 (881.191956)
Sun Nov 27 12:19:28.803 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:28.804 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.806 2005: do_lag: lag 1x2 = -5.2 (1080.709961)
Sun Nov 27 12:19:28.806 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:28.806 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:28.808 2005: do_lag: lag 1x3 = -15.2 (886.731140)
Sun Nov 27 12:19:28.808 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:28.808 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.810 2005: do_lag: lag 2x3 = -9.9 (920.676025)
Sun Nov 27 12:19:28.810 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:28.810 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=15.056393
Sun Nov 27 12:19:28.810 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=70.34, phi=356.58, speed=0.006708
Sun Nov 27 12:19:28.810 2005: ar_find_doa2: final offsets are -3.412134, 7.204778, 2.232828, -7.204778
Sun Nov 27 12:19:28.810 2005: ar_find_doa2: correcting for delta of -0.17...
Sun Nov 27 12:19:28.811 2005: ar_find_doa2: correcting for delta of -0.62...
Sun Nov 27 12:19:28.811 2005: ar_find_doa2: correcting for delta of -0.04...
Sun Nov 27 12:19:28.811 2005: ar_find_doa2: correcting for delta of 0.28...
Sun Nov 27 12:19:28.811 2005: ar_find_doa2: correcting for delta of 0.25...
Sun Nov 27 12:19:28.811 2005: ar_find_doa2: correcting for delta of 0.00...
Sun Nov 27 12:19:28.811 2005: ar_find_doa2: Found crossing point at index 302 (i.e. 4293.75), conf=16.099810
Sun Nov 27 12:19:28.811 2005: ar_process_chirp: Theta = 70.341919 degrees, phi = 356.579285 degrees, SNR = 0.664170
Sun Nov 27 12:19:28.811 2005: ar_process_chirp: Final answer: 4293.75[conf=16.099810], max value=10035.207031
Sun Nov 27 12:19:28.817 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:28.817 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:28.817 2005: process_file: node 0 Recorded distance of 30.280000 [16.000000] from node 0.0.0.100
Sun Nov 27 12:19:28.817 2005: process_file: **** Processing file ar-raw-6920-100-104:
Sun Nov 27 12:19:28.840 2005: process_file: **** Timing error was 6.395311 
Sun Nov 27 12:19:28.841 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8192.05, frac=0.85
Sun Nov 27 12:19:28.874 2005: ar_find_max: Initial mean/stddev: 10.666088/7.916564 (thresh=100)
Sun Nov 27 12:19:28.875 2005: ar_find_max: tracing, index 6437 sig=583.366150 m/s=36.535847/28.787512
Sun Nov 27 12:19:28.875 2005: ar_find_max: tracing, index 6438 sig=817.517578 m/s=36.535847/28.787512
Sun Nov 27 12:19:28.875 2005: ar_find_max:   Max conf is 27.13 (stddev=28.79)
Sun Nov 27 12:19:28.875 2005: ar_find_doa2: Found peak of 817.517578[28.398341] at 6438, channel 0
Sun Nov 27 12:19:28.875 2005: ar_find_max: Initial mean/stddev: 18.524670/13.879380 (thresh=100)
Sun Nov 27 12:19:28.876 2005: ar_find_max: tracing, index 6429 sig=928.807617 m/s=42.895607/44.463650
Sun Nov 27 12:19:28.876 2005: ar_find_max: tracing, index 6430 sig=1016.093872 m/s=42.895607/44.463650
Sun Nov 27 12:19:28.876 2005: ar_find_max:   Max conf is 21.89 (stddev=44.46)
Sun Nov 27 12:19:28.876 2005: ar_find_doa2: Found peak of 1016.093872[22.852237] at 6430, channel 1
Sun Nov 27 12:19:28.876 2005: ar_find_max: Initial mean/stddev: 9.327646/7.720849 (thresh=100)
Sun Nov 27 12:19:28.877 2005: ar_find_max: tracing, index 6436 sig=476.100952 m/s=27.584663/25.310976
Sun Nov 27 12:19:28.877 2005: ar_find_max: tracing, index 6437 sig=519.267944 m/s=27.584663/25.310976
Sun Nov 27 12:19:28.877 2005: ar_find_max:   Max conf is 19.43 (stddev=25.31)
Sun Nov 27 12:19:28.877 2005: ar_find_doa2: Found peak of 519.267944[20.515524] at 6437, channel 2
Sun Nov 27 12:19:28.877 2005: ar_find_max: Initial mean/stddev: 5.748448/4.389002 (thresh=100)
Sun Nov 27 12:19:28.877 2005: ar_find_max: tracing, index 6445 sig=304.970520 m/s=18.386517/15.607585
Sun Nov 27 12:19:28.877 2005: ar_find_max: tracing, index 6446 sig=448.553741 m/s=18.386517/15.607585
Sun Nov 27 12:19:28.878 2005: ar_find_max:   Max conf is 27.56 (stddev=15.61)
Sun Nov 27 12:19:28.878 2005: ar_find_doa2: Found peak of 448.553741[28.739471] at 6446, channel 3
Sun Nov 27 12:19:28.884 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:28.888 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:28.892 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:28.896 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:28.896 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.898 2005: do_lag: lag 0x1 = 8.5 (188.095734)
Sun Nov 27 12:19:28.898 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:28.898 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:28.900 2005: do_lag: lag 0x2 = 1.1 (145.610535)
Sun Nov 27 12:19:28.900 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:28.900 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:28.902 2005: do_lag: lag 0x3 = -7.9 (182.738403)
Sun Nov 27 12:19:28.902 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:28.902 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.904 2005: do_lag: lag 1x2 = -7.1 (183.344116)
Sun Nov 27 12:19:28.904 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:28.904 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:28.906 2005: do_lag: lag 1x3 = -16.4 (205.048767)
Sun Nov 27 12:19:28.906 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:28.906 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:28.909 2005: do_lag: lag 2x3 = -9.1 (163.210220)
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: estimate theta=15.00, phi=15.00, min_error=15.704777
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=46.87, phi=2.07, speed=0.006913
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: final offsets are -0.259784, 7.976727, 0.972307, -7.976727
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: correcting for delta of -0.08...
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: correcting for delta of -0.17...
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: correcting for delta of -0.03...
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: correcting for delta of -0.15...
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: correcting for delta of 0.22...
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: correcting for delta of -0.13...
Sun Nov 27 12:19:28.909 2005: ar_find_doa2: Found crossing point at index 318 (i.e. 6437.75), conf=11.159841
Sun Nov 27 12:19:28.909 2005: ar_process_chirp: Theta = 46.865337 degrees, phi = 2.065975 degrees, SNR = 0.636749
Sun Nov 27 12:19:28.909 2005: ar_process_chirp: Final answer: 6437.75[conf=11.159841], max value=3859.122559
Sun Nov 27 12:19:28.918 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:28.918 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:28.918 2005: process_file: node 0 Recorded distance of 45.753000 [11.100000] from node 0.0.0.100
Sun Nov 27 12:19:28.918 2005: process_file: **** Processing file ar-raw-6920-100-110:
Sun Nov 27 12:19:28.921 2005: process_file: **** unable to open file ar-raw-6920-100-110: No such file or directory
Sun Nov 27 12:19:28.921 2005: process_file: **** Processing file ar-raw-6920-100-111:
Sun Nov 27 12:19:28.924 2005: process_file: **** unable to open file ar-raw-6920-100-111: No such file or directory
Sun Nov 27 12:19:28.924 2005: process_file: **** Processing file ar-raw-6920-100-106:
Sun Nov 27 12:19:28.944 2005: process_file: **** Timing error was 5.000000 
Sun Nov 27 12:19:28.944 2005: ar_process_chirp: Beginning new chirp [1]: seed=70, mod=0, obslen=8192.00, frac=0.05
Sun Nov 27 12:19:28.978 2005: ar_find_max: Initial mean/stddev: 4.740993/3.671489 (thresh=100)
Sun Nov 27 12:19:28.979 2005: ar_find_max: tracing, index 8794 sig=263.602417 m/s=15.326122/17.898333
Sun Nov 27 12:19:28.979 2005: ar_find_max:   Max conf is 13.87 (stddev=17.90)
Sun Nov 27 12:19:28.979 2005: ar_find_doa2: Found peak of 263.602417[14.727764] at 8794, channel 0
Sun Nov 27 12:19:28.979 2005: ar_find_max: Initial mean/stddev: 5.817974/4.064689 (thresh=100)
Sun Nov 27 12:19:28.982 2005: ar_find_max: tracing, index 8782 sig=456.351135 m/s=24.487452/34.836720
Sun Nov 27 12:19:28.982 2005: ar_find_max:   Max conf is 12.40 (stddev=34.84)
Sun Nov 27 12:19:28.982 2005: ar_find_doa2: Found peak of 456.351135[13.099716] at 8782, channel 1
Sun Nov 27 12:19:28.982 2005: ar_find_max: Initial mean/stddev: 4.143198/2.626084 (thresh=100)
Sun Nov 27 12:19:28.984 2005: ar_find_max:   Max conf is 11.30 (stddev=4.10)
Sun Nov 27 12:19:28.984 2005: ar_find_max: Initial mean/stddev: 5.612020/4.045355 (thresh=100)
Sun Nov 27 12:19:28.986 2005: ar_find_max:   Max conf is 11.85 (stddev=4.98)
Sun Nov 27 12:19:28.990 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:28.994 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:28.998 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.002 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.002 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.004 2005: do_lag: lag 0x1 = 12.1 (74.175934)
Sun Nov 27 12:19:29.004 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.004 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.007 2005: do_lag: lag 0x2 = 11.8 (81.875229)
Sun Nov 27 12:19:29.007 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.007 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.008 2005: do_lag: lag 0x3 = -1.1 (77.242195)
Sun Nov 27 12:19:29.008 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.008 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.011 2005: do_lag: lag 1x2 = -0.5 (97.442215)
Sun Nov 27 12:19:29.011 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.011 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.012 2005: do_lag: lag 1x3 = -13.4 (100.278519)
Sun Nov 27 12:19:29.013 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.013 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.015 2005: do_lag: lag 2x3 = -12.9 (122.193718)
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=9.201866
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=84.58, phi=1.90, speed=0.006529
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: final offsets are -5.085152, 6.152219, 5.739818, -6.152219
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: correcting for delta of 0.54...
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: correcting for delta of -0.21...
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: correcting for delta of 0.51...
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: correcting for delta of -0.06...
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: correcting for delta of -0.55...
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: correcting for delta of -0.38...
Sun Nov 27 12:19:29.015 2005: ar_find_doa2: Found crossing point at index 312 (i.e. 8789.00), conf=20.952461
Sun Nov 27 12:19:29.015 2005: ar_process_chirp: Theta = 84.575630 degrees, phi = 1.898155 degrees, SNR = 1.086736
Sun Nov 27 12:19:29.015 2005: ar_process_chirp: Final answer: 8789.00[conf=20.952461], max value=4467.927734
Sun Nov 27 12:19:29.027 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.027 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.027 2005: process_file: node 0 Recorded distance of 62.728000 [20.900000] from node 0.0.0.100
Sun Nov 27 12:19:29.027 2005: process_file: **** Processing file ar-raw-6920-100-109:
Sun Nov 27 12:19:29.030 2005: process_file: **** unable to open file ar-raw-6920-100-109: No such file or directory
Sun Nov 27 12:19:29.030 2005: process_file: **** Processing file ar-raw-6921-100-100:
Sun Nov 27 12:19:29.033 2005: process_file: **** Orig dist was 326.250000 
Sun Nov 27 12:19:29.033 2005: process_file: **** Timing error was 2.387467 
Sun Nov 27 12:19:29.033 2005: ar_process_chirp: Beginning new chirp [1]: seed=903, mod=0, obslen=8192.00, frac=0.05
Sun Nov 27 12:19:29.049 2005: ar_process_chirp: subsample ifft'd local recording
Sun Nov 27 12:19:29.050 2005: ar_process_chirp: ***Selfrange average = 6447.547852, frac over = 119.754982
Sun Nov 27 12:19:29.050 2005: ar_process_chirp: Final answer: 331.75[conf=119.754982], max value=772126.000000
Sun Nov 27 12:19:29.050 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.050 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.050 2005: process_file: node 100 Recorded distance of 1.692000 [119.700000] from node 0.0.0.100
Sun Nov 27 12:19:29.050 2005: main: **** OFFSET=5!!!
Sun Nov 27 12:19:29.050 2005: process_file: **** Processing file ar-raw-6921-100-103:
Sun Nov 27 12:19:29.053 2005: process_file: **** unable to open file ar-raw-6921-100-103: No such file or directory
Sun Nov 27 12:19:29.053 2005: process_file: **** Processing file ar-raw-6921-100-102:
Sun Nov 27 12:19:29.055 2005: process_file: **** unable to open file ar-raw-6921-100-102: No such file or directory
Sun Nov 27 12:19:29.055 2005: process_file: **** Processing file ar-raw-6921-100-108:
Sun Nov 27 12:19:29.058 2005: process_file: **** unable to open file ar-raw-6921-100-108: No such file or directory
Sun Nov 27 12:19:29.058 2005: process_file: **** Processing file ar-raw-6921-100-105:
Sun Nov 27 12:19:29.061 2005: process_file: **** unable to open file ar-raw-6921-100-105: No such file or directory
Sun Nov 27 12:19:29.061 2005: process_file: **** Processing file ar-raw-6921-100-104:
Sun Nov 27 12:19:29.064 2005: process_file: **** unable to open file ar-raw-6921-100-104: No such file or directory
Sun Nov 27 12:19:29.064 2005: process_file: **** Processing file ar-raw-6921-100-110:
Sun Nov 27 12:19:29.067 2005: process_file: **** unable to open file ar-raw-6921-100-110: No such file or directory
Sun Nov 27 12:19:29.067 2005: process_file: **** Processing file ar-raw-6921-100-111:
Sun Nov 27 12:19:29.069 2005: process_file: **** unable to open file ar-raw-6921-100-111: No such file or directory
Sun Nov 27 12:19:29.070 2005: process_file: **** Processing file ar-raw-6921-100-106:
Sun Nov 27 12:19:29.072 2005: process_file: **** unable to open file ar-raw-6921-100-106: No such file or directory
Sun Nov 27 12:19:29.072 2005: process_file: **** Processing file ar-raw-6921-100-109:
Sun Nov 27 12:19:29.075 2005: process_file: **** unable to open file ar-raw-6921-100-109: No such file or directory
Sun Nov 27 12:19:29.075 2005: process_file: **** Processing file ar-raw-6922-100-100:
Sun Nov 27 12:19:29.078 2005: process_file: **** Orig dist was 320.250000 
Sun Nov 27 12:19:29.078 2005: process_file: **** Timing error was 6.395311 
Sun Nov 27 12:19:29.078 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8192.00, frac=0.65
Sun Nov 27 12:19:29.096 2005: ar_process_chirp: subsample ifft'd local recording
Sun Nov 27 12:19:29.096 2005: ar_process_chirp: ***Selfrange average = 6256.786621, frac over = 131.891357
Sun Nov 27 12:19:29.096 2005: ar_process_chirp: Final answer: 325.88[conf=131.891357], max value=825216.062500
Sun Nov 27 12:19:29.096 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.096 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.096 2005: process_file: node 100 Recorded distance of 1.645000 [131.800000] from node 0.0.0.100
Sun Nov 27 12:19:29.096 2005: main: **** OFFSET=5!!!
Sun Nov 27 12:19:29.096 2005: process_file: **** Processing file ar-raw-6922-100-103:
Sun Nov 27 12:19:29.100 2005: process_file: **** Timing error was 2.387467 
Sun Nov 27 12:19:29.100 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8191.85, frac=0.00
Sun Nov 27 12:19:29.133 2005: ar_find_max: Initial mean/stddev: 78.090958/55.355133 (thresh=100)
Sun Nov 27 12:19:29.134 2005: ar_find_max: tracing, index 3097 sig=-1840.109131 m/s=102.086960/114.118896
Sun Nov 27 12:19:29.134 2005: ar_find_max:   Max conf is 15.23 (stddev=114.12)
Sun Nov 27 12:19:29.134 2005: ar_find_doa2: Found peak of 1840.109131[16.124491] at 3097, channel 0
Sun Nov 27 12:19:29.134 2005: ar_find_max: Initial mean/stddev: 98.261864/75.981834 (thresh=100)
Sun Nov 27 12:19:29.134 2005: ar_find_max: tracing, index 3085 sig=-3227.619873 m/s=134.615692/153.416977
Sun Nov 27 12:19:29.134 2005: ar_find_max:   Max conf is 20.16 (stddev=153.42)
Sun Nov 27 12:19:29.134 2005: ar_find_doa2: Found peak of 3227.619873[21.038218] at 3085, channel 1
Sun Nov 27 12:19:29.134 2005: ar_find_max: Initial mean/stddev: 165.427246/125.391273 (thresh=100)
Sun Nov 27 12:19:29.136 2005: ar_find_max:   Max conf is 11.79 (stddev=117.69)
Sun Nov 27 12:19:29.136 2005: ar_find_max: Initial mean/stddev: 101.855721/78.480896 (thresh=100)
Sun Nov 27 12:19:29.137 2005: ar_find_max: tracing, index 3097 sig=-3442.043213 m/s=162.440155/177.601944
Sun Nov 27 12:19:29.137 2005: ar_find_max:   Max conf is 18.47 (stddev=177.60)
Sun Nov 27 12:19:29.137 2005: ar_find_doa2: Found peak of 3442.043213[19.380662] at 3097, channel 3
Sun Nov 27 12:19:29.141 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.145 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.149 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.153 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.153 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.155 2005: do_lag: lag 0x1 = 11.8 (12831.761719)
Sun Nov 27 12:19:29.155 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.155 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.158 2005: do_lag: lag 0x2 = 12.5 (13542.757812)
Sun Nov 27 12:19:29.158 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.158 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.159 2005: do_lag: lag 0x3 = 0.2 (14961.249023)
Sun Nov 27 12:19:29.159 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.159 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.162 2005: do_lag: lag 1x2 = 0.6 (14947.902344)
Sun Nov 27 12:19:29.162 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.162 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.164 2005: do_lag: lag 1x3 = -11.6 (15667.151367)
Sun Nov 27 12:19:29.164 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.164 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.166 2005: do_lag: lag 2x3 = -12.2 (16782.812500)
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=15.813872
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=91.07, phi=1.39, speed=0.006767
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: final offsets are -5.749730, 5.539087, 6.229953, -5.539087
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: correcting for delta of 0.35...
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: correcting for delta of 0.28...
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: correcting for delta of -0.03...
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: correcting for delta of -0.25...
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: correcting for delta of -0.22...
Sun Nov 27 12:19:29.166 2005: ar_find_doa2: correcting for delta of -0.12...
Sun Nov 27 12:19:29.167 2005: ar_find_doa2: Found crossing point at index 320 (i.e. 3093.00), conf=19.641939
Sun Nov 27 12:19:29.167 2005: ar_process_chirp: Theta = 91.068985 degrees, phi = 1.392253 degrees, SNR = 0.632356
Sun Nov 27 12:19:29.167 2005: ar_process_chirp: Final answer: 3093.00[conf=19.641939], max value=48862.210938
Sun Nov 27 12:19:29.172 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.172 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.172 2005: process_file: node 0 Recorded distance of 21.620000 [19.600000] from node 0.0.0.100
Sun Nov 27 12:19:29.172 2005: process_file: **** Processing file ar-raw-6922-100-102:
Sun Nov 27 12:19:29.177 2005: process_file: **** Timing error was 4.289522 
Sun Nov 27 12:19:29.177 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8191.90, frac=0.55
Sun Nov 27 12:19:29.213 2005: ar_find_max: Initial mean/stddev: 39.583591/26.256817 (thresh=100)
Sun Nov 27 12:19:29.213 2005: ar_find_max: tracing, index 5094 sig=809.431152 m/s=59.662476/58.517288
Sun Nov 27 12:19:29.213 2005: ar_find_max: tracing, index 5095 sig=1043.032959 m/s=59.662476/58.517288
Sun Nov 27 12:19:29.213 2005: ar_find_max:   Max conf is 16.80 (stddev=58.52)
Sun Nov 27 12:19:29.213 2005: ar_find_doa2: Found peak of 1043.032959[17.824356] at 5095, channel 0
Sun Nov 27 12:19:29.213 2005: ar_find_max: Initial mean/stddev: 41.778633/29.775959 (thresh=100)
Sun Nov 27 12:19:29.214 2005: ar_find_max: tracing, index 5080 sig=-828.093628 m/s=72.476120/62.936214
Sun Nov 27 12:19:29.214 2005: ar_find_max:   Max conf is 12.01 (stddev=62.94)
Sun Nov 27 12:19:29.214 2005: ar_find_doa2: Found peak of 828.093628[13.157665] at 5080, channel 1
Sun Nov 27 12:19:29.214 2005: ar_find_max: Initial mean/stddev: 49.186554/36.472855 (thresh=100)
Sun Nov 27 12:19:29.216 2005: ar_find_max:   Max conf is 11.43 (stddev=31.31)
Sun Nov 27 12:19:29.216 2005: ar_find_max: Initial mean/stddev: 43.147179/34.051403 (thresh=100)
Sun Nov 27 12:19:29.217 2005: ar_find_max: tracing, index 5095 sig=-1176.483154 m/s=93.114517/81.659554
Sun Nov 27 12:19:29.217 2005: ar_find_max:   Max conf is 13.27 (stddev=81.66)
Sun Nov 27 12:19:29.217 2005: ar_find_doa2: Found peak of 1176.483154[14.407171] at 5095, channel 3
Sun Nov 27 12:19:29.221 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.225 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.229 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.233 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.233 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.235 2005: do_lag: lag 0x1 = 12.0 (2582.524658)
Sun Nov 27 12:19:29.235 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.235 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.238 2005: do_lag: lag 0x2 = 15.0 (2539.581543)
Sun Nov 27 12:19:29.238 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.238 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.239 2005: do_lag: lag 0x3 = -3.5 (1604.953247)
Sun Nov 27 12:19:29.239 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.239 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.242 2005: do_lag: lag 1x2 = 3.0 (3191.198242)
Sun Nov 27 12:19:29.242 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.242 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.243 2005: do_lag: lag 1x3 = -15.5 (1922.384033)
Sun Nov 27 12:19:29.244 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.244 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.246 2005: do_lag: lag 2x3 = -18.5 (1845.349609)
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=13.712671
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=73.72, phi=16.68, speed=0.006132
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: final offsets are -3.675709, 6.709421, 9.347096, -6.709421
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: correcting for delta of -0.23...
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: correcting for delta of -1.35...
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: correcting for delta of -0.78...
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: correcting for delta of 1.13...
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: correcting for delta of 0.63...
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: correcting for delta of -0.17...
Sun Nov 27 12:19:29.246 2005: ar_find_doa2: Found crossing point at index 431 (i.e. 5101.88), conf=17.041746
Sun Nov 27 12:19:29.246 2005: ar_process_chirp: Theta = 73.715820 degrees, phi = 16.675158 degrees, SNR = 0.729253
Sun Nov 27 12:19:29.246 2005: ar_process_chirp: Final answer: 5101.88[conf=17.041746], max value=16953.246094
Sun Nov 27 12:19:29.254 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.254 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.254 2005: process_file: node 0 Recorded distance of 36.115000 [17.000000] from node 0.0.0.100
Sun Nov 27 12:19:29.254 2005: process_file: **** Processing file ar-raw-6922-100-108:
Sun Nov 27 12:19:29.258 2005: process_file: **** Timing error was 6.099180 
Sun Nov 27 12:19:29.258 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8191.85, frac=0.85
Sun Nov 27 12:19:29.294 2005: ar_find_max: Initial mean/stddev: 7.013070/4.432607 (thresh=100)
Sun Nov 27 12:19:29.294 2005: ar_find_max: tracing, index 5684 sig=181.168427 m/s=11.976541/9.526409
Sun Nov 27 12:19:29.294 2005: ar_find_max: tracing, index 5685 sig=221.755890 m/s=11.976541/9.526409
Sun Nov 27 12:19:29.294 2005: ar_find_max:   Max conf is 22.02 (stddev=9.53)
Sun Nov 27 12:19:29.294 2005: ar_find_doa2: Found peak of 221.755890[23.278014] at 5685, channel 0
Sun Nov 27 12:19:29.294 2005: ar_find_max: Initial mean/stddev: 3.388296/2.281213 (thresh=100)
Sun Nov 27 12:19:29.295 2005: ar_find_max: tracing, index 5674 sig=81.332390 m/s=4.181727/3.455001
Sun Nov 27 12:19:29.295 2005: ar_find_max:   Max conf is 22.33 (stddev=3.46)
Sun Nov 27 12:19:29.295 2005: ar_find_doa2: Found peak of 81.332390[23.540480] at 5674, channel 1
Sun Nov 27 12:19:29.295 2005: ar_find_max: Initial mean/stddev: 9.437679/6.715478 (thresh=100)
Sun Nov 27 12:19:29.296 2005: ar_find_max: tracing, index 5677 sig=206.004379 m/s=15.292047/12.062208
Sun Nov 27 12:19:29.296 2005: ar_find_max:   Max conf is 15.81 (stddev=12.06)
Sun Nov 27 12:19:29.296 2005: ar_find_doa2: Found peak of 206.004379[17.078496] at 5677, channel 2
Sun Nov 27 12:19:29.296 2005: ar_find_max: Initial mean/stddev: 8.664255/6.491460 (thresh=100)
Sun Nov 27 12:19:29.297 2005: ar_find_max: tracing, index 5689 sig=190.213654 m/s=14.892939/11.414754
Sun Nov 27 12:19:29.297 2005: ar_find_max: tracing, index 5690 sig=237.135040 m/s=14.892939/11.414754
Sun Nov 27 12:19:29.297 2005: ar_find_max:   Max conf is 19.47 (stddev=11.41)
Sun Nov 27 12:19:29.297 2005: ar_find_doa2: Found peak of 237.135040[20.774433] at 5690, channel 3
Sun Nov 27 12:19:29.301 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.305 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.309 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.314 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.314 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.315 2005: do_lag: lag 0x1 = 10.2 (18.580948)
Sun Nov 27 12:19:29.315 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.315 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.318 2005: do_lag: lag 0x2 = 6.1 (13.538686)
Sun Nov 27 12:19:29.318 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.318 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.319 2005: do_lag: lag 0x3 = -4.9 (10.265639)
Sun Nov 27 12:19:29.319 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.319 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.322 2005: do_lag: lag 1x2 = -3.9 (17.055470)
Sun Nov 27 12:19:29.322 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.322 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.324 2005: do_lag: lag 1x3 = -15.2 (9.962276)
Sun Nov 27 12:19:29.324 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.324 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.326 2005: do_lag: lag 2x3 = -11.9 (8.934348)
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=8.020966
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=63.33, phi=3.76, speed=0.006985
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: final offsets are -2.506042, 7.564703, 3.800493, -7.564703
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: correcting for delta of -0.25...
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: correcting for delta of 0.00...
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: correcting for delta of 0.17...
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: correcting for delta of -0.28...
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: correcting for delta of -0.08...
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: correcting for delta of 0.19...
Sun Nov 27 12:19:29.326 2005: ar_find_doa2: Found crossing point at index 320 (i.e. 5682.00), conf=7.329526
Sun Nov 27 12:19:29.327 2005: ar_process_chirp: Theta = 63.329056 degrees, phi = 3.755160 degrees, SNR = 1.246733
Sun Nov 27 12:19:29.327 2005: ar_process_chirp: Final answer: 5682.00[conf=7.329526], max value=1280.483765
Sun Nov 27 12:19:29.335 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.335 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.335 2005: process_file: node 0 Recorded distance of 40.299000 [7.300000] from node 0.0.0.100
Sun Nov 27 12:19:29.335 2005: process_file: **** Processing file ar-raw-6922-100-105:
Sun Nov 27 12:19:29.339 2005: process_file: **** Timing error was 2.588436 
Sun Nov 27 12:19:29.339 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8192.00, frac=0.20
Sun Nov 27 12:19:29.373 2005: ar_find_max: Initial mean/stddev: 26.281406/18.962057 (thresh=100)
Sun Nov 27 12:19:29.373 2005: ar_find_max: tracing, index 4302 sig=1078.182861 m/s=54.818733/67.856567
Sun Nov 27 12:19:29.373 2005: ar_find_max: tracing, index 4303 sig=1474.017822 m/s=54.818733/67.856567
Sun Nov 27 12:19:29.373 2005: ar_find_max:   Max conf is 20.91 (stddev=67.86)
Sun Nov 27 12:19:29.373 2005: ar_find_doa2: Found peak of 1474.017822[21.722552] at 4303, channel 0
Sun Nov 27 12:19:29.373 2005: ar_find_max: Initial mean/stddev: 27.272606/22.663229 (thresh=100)
Sun Nov 27 12:19:29.374 2005: ar_find_max: tracing, index 4291 sig=1796.592285 m/s=76.731415/111.659378
Sun Nov 27 12:19:29.374 2005: ar_find_max: tracing, index 4292 sig=1867.692871 m/s=76.731415/111.659378
Sun Nov 27 12:19:29.374 2005: ar_find_max:   Max conf is 16.04 (stddev=111.66)
Sun Nov 27 12:19:29.374 2005: ar_find_doa2: Found peak of 1867.692871[16.726700] at 4292, channel 1
Sun Nov 27 12:19:29.374 2005: ar_find_max: Initial mean/stddev: 39.012520/30.630199 (thresh=100)
Sun Nov 27 12:19:29.375 2005: ar_find_max: tracing, index 4296 sig=1663.563232 m/s=83.995842/125.653183
Sun Nov 27 12:19:29.375 2005: ar_find_max: tracing, index 4297 sig=2257.017090 m/s=83.995842/125.653183
Sun Nov 27 12:19:29.375 2005: ar_find_max:   Max conf is 17.29 (stddev=125.65)
Sun Nov 27 12:19:29.375 2005: ar_find_doa2: Found peak of 2257.017090[17.962275] at 4297, channel 2
Sun Nov 27 12:19:29.375 2005: ar_find_max: Initial mean/stddev: 20.894140/17.932896 (thresh=100)
Sun Nov 27 12:19:29.375 2005: ar_find_max: tracing, index 4306 sig=1210.820312 m/s=56.829262/87.764908
Sun Nov 27 12:19:29.375 2005: ar_find_max: tracing, index 4307 sig=1463.347412 m/s=56.829262/87.764908
Sun Nov 27 12:19:29.375 2005: ar_find_max:   Max conf is 16.03 (stddev=87.76)
Sun Nov 27 12:19:29.375 2005: ar_find_doa2: Found peak of 1463.347412[16.673491] at 4307, channel 3
Sun Nov 27 12:19:29.379 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.385 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.390 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.394 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.394 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.395 2005: do_lag: lag 0x1 = 11.2 (1405.853760)
Sun Nov 27 12:19:29.395 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.395 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.398 2005: do_lag: lag 0x2 = 6.2 (1349.812134)
Sun Nov 27 12:19:29.398 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.398 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.399 2005: do_lag: lag 0x3 = -3.8 (1129.624390)
Sun Nov 27 12:19:29.400 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.400 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.402 2005: do_lag: lag 1x2 = -5.0 (1483.024536)
Sun Nov 27 12:19:29.402 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.402 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.404 2005: do_lag: lag 1x3 = -15.0 (1217.368042)
Sun Nov 27 12:19:29.404 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.404 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.406 2005: do_lag: lag 2x3 = -10.0 (1231.078125)
Sun Nov 27 12:19:29.406 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=14.137686
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=71.53, phi=356.72, speed=0.006737
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: final offsets are -3.561848, 7.133268, 2.432417, -7.133268
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: correcting for delta of -0.14...
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: correcting for delta of -0.55...
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: correcting for delta of -0.08...
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: correcting for delta of 0.26...
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: correcting for delta of 0.21...
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: correcting for delta of -0.09...
Sun Nov 27 12:19:29.407 2005: ar_find_doa2: Found crossing point at index 313 (i.e. 4299.12), conf=22.539694
Sun Nov 27 12:19:29.407 2005: ar_process_chirp: Theta = 71.534294 degrees, phi = 356.724121 degrees, SNR = 0.707329
Sun Nov 27 12:19:29.407 2005: ar_process_chirp: Final answer: 4299.12[conf=22.539694], max value=16000.253906
Sun Nov 27 12:19:29.413 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.413 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.413 2005: process_file: node 0 Recorded distance of 30.323000 [22.500000] from node 0.0.0.100
Sun Nov 27 12:19:29.414 2005: process_file: **** Processing file ar-raw-6922-100-104:
Sun Nov 27 12:19:29.418 2005: process_file: **** Timing error was 6.292853 
Sun Nov 27 12:19:29.418 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8191.95, frac=0.80
Sun Nov 27 12:19:29.452 2005: ar_find_max: Initial mean/stddev: 11.028833/7.347274 (thresh=100)
Sun Nov 27 12:19:29.452 2005: ar_find_max: tracing, index 6446 sig=603.500488 m/s=31.556648/30.434298
Sun Nov 27 12:19:29.452 2005: ar_find_max: tracing, index 6447 sig=669.680786 m/s=31.556648/30.434298
Sun Nov 27 12:19:29.453 2005: ar_find_max:   Max conf is 20.97 (stddev=30.43)
Sun Nov 27 12:19:29.453 2005: ar_find_doa2: Found peak of 669.680786[22.004148] at 6447, channel 0
Sun Nov 27 12:19:29.453 2005: ar_find_max: Initial mean/stddev: 18.535048/13.630436 (thresh=100)
Sun Nov 27 12:19:29.453 2005: ar_find_max: tracing, index 6438 sig=1248.939575 m/s=51.774368/63.570633
Sun Nov 27 12:19:29.453 2005: ar_find_max:   Max conf is 18.83 (stddev=63.57)
Sun Nov 27 12:19:29.453 2005: ar_find_doa2: Found peak of 1248.939575[19.646486] at 6438, channel 1
Sun Nov 27 12:19:29.453 2005: ar_find_max: Initial mean/stddev: 7.354534/5.519203 (thresh=100)
Sun Nov 27 12:19:29.454 2005: ar_find_max: tracing, index 6445 sig=729.372498 m/s=26.667362/38.921982
Sun Nov 27 12:19:29.454 2005: ar_find_max:   Max conf is 18.05 (stddev=38.92)
Sun Nov 27 12:19:29.454 2005: ar_find_doa2: Found peak of 729.372498[18.739346] at 6445, channel 2
Sun Nov 27 12:19:29.454 2005: ar_find_max: Initial mean/stddev: 6.455422/4.409350 (thresh=100)
Sun Nov 27 12:19:29.455 2005: ar_find_max: tracing, index 6454 sig=437.936920 m/s=20.409855/24.520889
Sun Nov 27 12:19:29.455 2005: ar_find_max: tracing, index 6455 sig=497.743958 m/s=20.409855/24.520889
Sun Nov 27 12:19:29.455 2005: ar_find_max:   Max conf is 19.47 (stddev=24.52)
Sun Nov 27 12:19:29.455 2005: ar_find_doa2: Found peak of 497.743958[20.298773] at 6455, channel 3
Sun Nov 27 12:19:29.459 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.463 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.468 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.472 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.472 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.474 2005: do_lag: lag 0x1 = 8.6 (239.437973)
Sun Nov 27 12:19:29.474 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.474 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.476 2005: do_lag: lag 0x2 = 1.6 (227.414841)
Sun Nov 27 12:19:29.476 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.476 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.478 2005: do_lag: lag 0x3 = -7.9 (236.530807)
Sun Nov 27 12:19:29.478 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.478 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.480 2005: do_lag: lag 1x2 = -7.0 (276.658722)
Sun Nov 27 12:19:29.480 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.480 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.482 2005: do_lag: lag 1x3 = -16.4 (300.964905)
Sun Nov 27 12:19:29.482 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.482 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.484 2005: do_lag: lag 2x3 = -9.5 (253.872360)
Sun Nov 27 12:19:29.484 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.484 2005: ar_find_doa2: estimate theta=15.00, phi=15.00, min_error=15.680524
Sun Nov 27 12:19:29.486 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=47.58, phi=2.58, speed=0.006871
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: final offsets are -0.359125, 7.969975, 1.248245, -7.969975
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: correcting for delta of 0.01...
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: correcting for delta of -0.21...
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: correcting for delta of 0.31...
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: correcting for delta of -0.14...
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: correcting for delta of -0.18...
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: correcting for delta of -0.01...
Sun Nov 27 12:19:29.487 2005: ar_find_doa2: Found crossing point at index 323 (i.e. 6446.38), conf=20.907692
Sun Nov 27 12:19:29.487 2005: ar_process_chirp: Theta = 47.579987 degrees, phi = 2.578335 degrees, SNR = 0.637734
Sun Nov 27 12:19:29.487 2005: ar_process_chirp: Final answer: 6446.38[conf=20.907692], max value=7425.864746
Sun Nov 27 12:19:29.496 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.496 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.496 2005: process_file: node 0 Recorded distance of 45.816000 [20.900000] from node 0.0.0.100
Sun Nov 27 12:19:29.496 2005: process_file: **** Processing file ar-raw-6922-100-110:
Sun Nov 27 12:19:29.499 2005: process_file: **** unable to open file ar-raw-6922-100-110: No such file or directory
Sun Nov 27 12:19:29.499 2005: process_file: **** Processing file ar-raw-6922-100-111:
Sun Nov 27 12:19:29.501 2005: process_file: **** unable to open file ar-raw-6922-100-111: No such file or directory
Sun Nov 27 12:19:29.501 2005: process_file: **** Processing file ar-raw-6922-100-106:
Sun Nov 27 12:19:29.505 2005: process_file: **** Timing error was 5.000000 
Sun Nov 27 12:19:29.505 2005: ar_process_chirp: Beginning new chirp [1]: seed=586, mod=0, obslen=8191.90, frac=0.55
Sun Nov 27 12:19:29.538 2005: ar_find_max: Initial mean/stddev: 7.859083/5.087162 (thresh=100)
Sun Nov 27 12:19:29.539 2005: ar_find_max: tracing, index 8812 sig=261.174347 m/s=15.371832/17.753923
Sun Nov 27 12:19:29.539 2005: ar_find_max: tracing, index 8813 sig=293.684937 m/s=15.371832/17.753923
Sun Nov 27 12:19:29.539 2005: ar_find_max:   Max conf is 15.68 (stddev=17.75)
Sun Nov 27 12:19:29.539 2005: ar_find_doa2: Found peak of 293.684937[16.541974] at 8813, channel 0
Sun Nov 27 12:19:29.539 2005: ar_find_max: Initial mean/stddev: 9.236220/7.298624 (thresh=100)
Sun Nov 27 12:19:29.540 2005: ar_find_max: tracing, index 8800 sig=507.995117 m/s=28.022152/36.546200
Sun Nov 27 12:19:29.540 2005: ar_find_max: tracing, index 8801 sig=581.062622 m/s=28.022152/36.546200
Sun Nov 27 12:19:29.540 2005: ar_find_max:   Max conf is 15.13 (stddev=36.55)
Sun Nov 27 12:19:29.540 2005: ar_find_doa2: Found peak of 581.062622[15.899399] at 8801, channel 1
Sun Nov 27 12:19:29.540 2005: ar_find_max: Initial mean/stddev: 5.594916/4.493917 (thresh=100)
Sun Nov 27 12:19:29.541 2005: ar_find_max: tracing, index 8801 sig=538.776245 m/s=22.579250/32.366333
Sun Nov 27 12:19:29.541 2005: ar_find_max:   Max conf is 15.95 (stddev=32.37)
Sun Nov 27 12:19:29.541 2005: ar_find_doa2: Found peak of 538.776245[16.646194] at 8801, channel 2
Sun Nov 27 12:19:29.541 2005: ar_find_max: Initial mean/stddev: 11.387903/6.759503 (thresh=100)
Sun Nov 27 12:19:29.542 2005: ar_find_max: tracing, index 8814 sig=718.839966 m/s=34.088577/52.523708
Sun Nov 27 12:19:29.542 2005: ar_find_max:   Max conf is 13.04 (stddev=52.52)
Sun Nov 27 12:19:29.543 2005: ar_find_doa2: Found peak of 718.839966[13.686009] at 8814, channel 3
Sun Nov 27 12:19:29.547 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.551 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.555 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.559 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.559 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.561 2005: do_lag: lag 0x1 = 12.0 (106.049393)
Sun Nov 27 12:19:29.561 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.561 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.563 2005: do_lag: lag 0x2 = 11.5 (92.917633)
Sun Nov 27 12:19:29.563 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.563 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.565 2005: do_lag: lag 0x3 = -1.1 (98.159630)
Sun Nov 27 12:19:29.565 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.565 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.567 2005: do_lag: lag 1x2 = -0.6 (125.420845)
Sun Nov 27 12:19:29.567 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.568 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.570 2005: do_lag: lag 1x3 = -13.4 (138.022522)
Sun Nov 27 12:19:29.570 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.570 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.572 2005: do_lag: lag 2x3 = -12.8 (141.740952)
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=10.029107
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=84.20, phi=1.77, speed=0.006577
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: final offsets are -5.044806, 6.186082, 5.655360, -6.186082
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: correcting for delta of 0.52...
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: correcting for delta of -0.17...
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: correcting for delta of 0.44...
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: correcting for delta of -0.12...
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: correcting for delta of -0.62...
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: correcting for delta of -0.31...
Sun Nov 27 12:19:29.572 2005: ar_find_doa2: Found crossing point at index 306 (i.e. 8807.25), conf=21.213171
Sun Nov 27 12:19:29.572 2005: ar_process_chirp: Theta = 84.197556 degrees, phi = 1.770214 degrees, SNR = 0.997098
Sun Nov 27 12:19:29.572 2005: ar_process_chirp: Final answer: 8807.25[conf=21.213171], max value=5320.818359
Sun Nov 27 12:19:29.584 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.584 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.584 2005: process_file: node 0 Recorded distance of 62.856000 [21.200000] from node 0.0.0.100
Sun Nov 27 12:19:29.584 2005: process_file: **** Processing file ar-raw-6922-100-109:
Sun Nov 27 12:19:29.589 2005: process_file: **** unable to open file ar-raw-6922-100-109: No such file or directory
Sun Nov 27 12:19:29.589 2005: process_file: **** Processing file ar-raw-6923-100-100:
Sun Nov 27 12:19:29.615 2005: process_file: **** Orig dist was 462.250000 
Sun Nov 27 12:19:29.615 2005: process_file: **** Timing error was 5.796551 
Sun Nov 27 12:19:29.615 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8192.00, frac=0.90
Sun Nov 27 12:19:29.632 2005: ar_process_chirp: subsample ifft'd local recording
Sun Nov 27 12:19:29.632 2005: ar_process_chirp: ***Selfrange average = 6596.881836, frac over = 125.975067
Sun Nov 27 12:19:29.632 2005: ar_process_chirp: Final answer: 467.88[conf=125.975067], max value=831042.625000
Sun Nov 27 12:19:29.632 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.632 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.632 2005: process_file: node 100 Recorded distance of 2.668000 [125.900000] from node 0.0.0.100
Sun Nov 27 12:19:29.632 2005: main: **** OFFSET=5!!!
Sun Nov 27 12:19:29.632 2005: process_file: **** Processing file ar-raw-6923-100-103:
Sun Nov 27 12:19:29.635 2005: process_file: **** Timing error was 3.898718 
Sun Nov 27 12:19:29.635 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8192.00, frac=0.30
Sun Nov 27 12:19:29.668 2005: ar_find_max: Initial mean/stddev: 74.337700/47.126713 (thresh=100)
Sun Nov 27 12:19:29.669 2005: ar_find_max: tracing, index 3096 sig=-1318.508301 m/s=106.365204/94.730637
Sun Nov 27 12:19:29.669 2005: ar_find_max:   Max conf is 12.80 (stddev=94.73)
Sun Nov 27 12:19:29.669 2005: ar_find_doa2: Found peak of 1318.508301[13.918499] at 3096, channel 0
Sun Nov 27 12:19:29.669 2005: ar_find_max: Initial mean/stddev: 97.709061/74.587631 (thresh=100)
Sun Nov 27 12:19:29.669 2005: ar_find_max: tracing, index 3085 sig=-2497.938477 m/s=151.677032/184.847000
Sun Nov 27 12:19:29.669 2005: ar_find_max: tracing, index 3086 sig=2736.325684 m/s=151.677032/184.847000
Sun Nov 27 12:19:29.669 2005: ar_find_max: tracing, index 3087 sig=4625.336914 m/s=151.677032/184.847000
Sun Nov 27 12:19:29.669 2005: ar_find_max:   Max conf is 24.20 (stddev=184.85)
Sun Nov 27 12:19:29.669 2005: ar_find_doa2: Found peak of 4625.336914[25.022515] at 3087, channel 1
Sun Nov 27 12:19:29.669 2005: ar_find_max: Initial mean/stddev: 217.504700/150.648560 (thresh=100)
Sun Nov 27 12:19:29.670 2005: ar_find_max: tracing, index 3084 sig=-4913.110352 m/s=280.122162/261.418182
Sun Nov 27 12:19:29.670 2005: ar_find_max:   Max conf is 17.72 (stddev=261.42)
Sun Nov 27 12:19:29.670 2005: ar_find_doa2: Found peak of 4913.110352[18.794065] at 3084, channel 2
Sun Nov 27 12:19:29.670 2005: ar_find_max: Initial mean/stddev: 112.384880/73.917953 (thresh=100)
Sun Nov 27 12:19:29.670 2005: ar_find_max: tracing, index 3096 sig=-2287.800537 m/s=141.945801/134.469543
Sun Nov 27 12:19:29.670 2005: ar_find_max:   Max conf is 15.96 (stddev=134.47)
Sun Nov 27 12:19:29.670 2005: ar_find_doa2: Found peak of 2287.800537[17.013522] at 3096, channel 3
Sun Nov 27 12:19:29.674 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.679 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.683 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.687 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.687 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.691 2005: do_lag: lag 0x1 = 11.8 (10434.039062)
Sun Nov 27 12:19:29.691 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.691 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.693 2005: do_lag: lag 0x2 = 12.6 (10092.962891)
Sun Nov 27 12:19:29.693 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.693 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.695 2005: do_lag: lag 0x3 = 0.2 (12124.376953)
Sun Nov 27 12:19:29.695 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.695 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.697 2005: do_lag: lag 1x2 = 0.8 (11652.117188)
Sun Nov 27 12:19:29.697 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.697 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.699 2005: do_lag: lag 1x3 = -11.5 (12625.041992)
Sun Nov 27 12:19:29.699 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.699 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.702 2005: do_lag: lag 2x3 = -12.2 (12482.407227)
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=16.886974
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=91.36, phi=1.58, speed=0.006786
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: final offsets are -5.777582, 5.509072, 6.320963, -5.509072
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: correcting for delta of 0.42...
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: correcting for delta of 0.21...
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: correcting for delta of -0.15...
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: correcting for delta of -0.32...
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: correcting for delta of -0.13...
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: correcting for delta of -0.08...
Sun Nov 27 12:19:29.702 2005: ar_find_doa2: Found crossing point at index 324 (i.e. 3092.50), conf=20.592846
Sun Nov 27 12:19:29.702 2005: ar_process_chirp: Theta = 91.362808 degrees, phi = 1.575404 degrees, SNR = 0.592172
Sun Nov 27 12:19:29.702 2005: ar_process_chirp: Final answer: 3092.50[conf=20.592846], max value=43409.667969
Sun Nov 27 12:19:29.707 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.707 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.708 2005: process_file: node 0 Recorded distance of 21.614000 [20.500000] from node 0.0.0.100
Sun Nov 27 12:19:29.708 2005: process_file: **** Processing file ar-raw-6923-100-102:
Sun Nov 27 12:19:29.712 2005: process_file: **** Timing error was 4.690416 
Sun Nov 27 12:19:29.713 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8191.90, frac=0.85
Sun Nov 27 12:19:29.745 2005: ar_find_max: Initial mean/stddev: 42.274174/27.156828 (thresh=100)
Sun Nov 27 12:19:29.746 2005: ar_find_max: tracing, index 5090 sig=1033.949219 m/s=63.109047/66.325882
Sun Nov 27 12:19:29.746 2005: ar_find_max:   Max conf is 14.64 (stddev=66.33)
Sun Nov 27 12:19:29.746 2005: ar_find_doa2: Found peak of 1033.949219[15.588925] at 5090, channel 0
Sun Nov 27 12:19:29.746 2005: ar_find_max: Initial mean/stddev: 51.940117/37.683392 (thresh=100)
Sun Nov 27 12:19:29.747 2005: ar_find_max: tracing, index 5076 sig=-1023.427246 m/s=66.811470/75.858383
Sun Nov 27 12:19:29.747 2005: ar_find_max:   Max conf is 12.61 (stddev=75.86)
Sun Nov 27 12:19:29.747 2005: ar_find_doa2: Found peak of 1023.427246[13.491287] at 5076, channel 1
Sun Nov 27 12:19:29.747 2005: ar_find_max: Initial mean/stddev: 42.376068/30.488901 (thresh=100)
Sun Nov 27 12:19:29.747 2005: ar_find_max: tracing, index 5075 sig=1825.926514 m/s=78.751198/115.180710
Sun Nov 27 12:19:29.747 2005: ar_find_max:   Max conf is 15.17 (stddev=115.18)
Sun Nov 27 12:19:29.747 2005: ar_find_doa2: Found peak of 1825.926514[15.852711] at 5075, channel 2
Sun Nov 27 12:19:29.747 2005: ar_find_max: Initial mean/stddev: 62.484692/46.553257 (thresh=100)
Sun Nov 27 12:19:29.748 2005: ar_find_max: tracing, index 5094 sig=3062.764648 m/s=146.315460/235.242661
Sun Nov 27 12:19:29.748 2005: ar_find_max:   Max conf is 12.40 (stddev=235.24)
Sun Nov 27 12:19:29.748 2005: ar_find_doa2: Found peak of 3062.764648[13.019597] at 5094, channel 3
Sun Nov 27 12:19:29.752 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.757 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.761 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.765 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.765 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.766 2005: do_lag: lag 0x1 = 12.0 (2619.348389)
Sun Nov 27 12:19:29.766 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.766 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.769 2005: do_lag: lag 0x2 = 15.1 (2685.310303)
Sun Nov 27 12:19:29.769 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.769 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.771 2005: do_lag: lag 0x3 = -3.5 (1929.117310)
Sun Nov 27 12:19:29.771 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.771 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.773 2005: do_lag: lag 1x2 = 3.0 (3129.644287)
Sun Nov 27 12:19:29.773 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.773 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.775 2005: do_lag: lag 1x3 = -3.9 (2034.060913)
Sun Nov 27 12:19:29.775 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.775 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.777 2005: do_lag: lag 2x3 = -18.6 (2109.707031)
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: estimate theta=105.00, phi=15.00, min_error=17.435085
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=87.79, phi=18.22, speed=0.007755
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: final offsets are -5.153335, 5.566517, 11.333368, -5.566517
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: correcting for delta of -1.90...
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: delta of 5.34 too large... ignoring xcorr 1x3
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: correcting for delta of -0.52...
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: correcting for delta of 1.87...
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: correcting for delta of -1.38...
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: correcting for delta of -1.41...
Sun Nov 27 12:19:29.778 2005: ar_find_doa2: Found crossing point at index 438 (i.e. 5097.75), conf=15.439389
Sun Nov 27 12:19:29.778 2005: ar_process_chirp: Theta = 87.792702 degrees, phi = 18.220829 degrees, SNR = 0.573556
Sun Nov 27 12:19:29.778 2005: ar_process_chirp: Final answer: 5097.75[conf=15.439389], max value=14416.386719
Sun Nov 27 12:19:29.785 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.785 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.785 2005: process_file: node 0 Recorded distance of 36.083000 [15.400000] from node 0.0.0.100
Sun Nov 27 12:19:29.786 2005: process_file: **** Processing file ar-raw-6923-100-108:
Sun Nov 27 12:19:29.790 2005: process_file: **** Timing error was 6.395311 
Sun Nov 27 12:19:29.791 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8191.90, frac=0.55
Sun Nov 27 12:19:29.824 2005: ar_find_max: Initial mean/stddev: 7.425080/4.748964 (thresh=100)
Sun Nov 27 12:19:29.825 2005: ar_find_max: tracing, index 5680 sig=141.722626 m/s=10.329494/8.044087
Sun Nov 27 12:19:29.825 2005: ar_find_max: tracing, index 5681 sig=188.109985 m/s=10.329494/8.044087
Sun Nov 27 12:19:29.825 2005: ar_find_max:   Max conf is 22.10 (stddev=8.04)
Sun Nov 27 12:19:29.825 2005: ar_find_doa2: Found peak of 188.109985[23.384876] at 5681, channel 0
Sun Nov 27 12:19:29.825 2005: ar_find_max: Initial mean/stddev: 2.276630/1.840718 (thresh=100)
Sun Nov 27 12:19:29.825 2005: ar_find_max: tracing, index 5670 sig=63.632507 m/s=4.165639/3.241659
Sun Nov 27 12:19:29.825 2005: ar_find_max: tracing, index 5671 sig=72.147408 m/s=4.165639/3.241659
Sun Nov 27 12:19:29.825 2005: ar_find_max:   Max conf is 20.97 (stddev=3.24)
Sun Nov 27 12:19:29.825 2005: ar_find_doa2: Found peak of 72.147408[22.256321] at 5671, channel 1
Sun Nov 27 12:19:29.825 2005: ar_find_max: Initial mean/stddev: 7.712208/5.250498 (thresh=100)
Sun Nov 27 12:19:29.826 2005: ar_find_max: tracing, index 5673 sig=192.655334 m/s=14.121445/14.295418
Sun Nov 27 12:19:29.826 2005: ar_find_max: tracing, index 5674 sig=197.059357 m/s=14.121445/14.295418
Sun Nov 27 12:19:29.826 2005: ar_find_max:   Max conf is 12.80 (stddev=14.30)
Sun Nov 27 12:19:29.826 2005: ar_find_doa2: Found peak of 197.059357[13.784792] at 5674, channel 2
Sun Nov 27 12:19:29.826 2005: ar_find_max: Initial mean/stddev: 9.342080/6.950548 (thresh=100)
Sun Nov 27 12:19:29.828 2005: ar_find_max:   Max conf is 11.81 (stddev=5.15)
Sun Nov 27 12:19:29.832 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.836 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.841 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.845 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.845 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.846 2005: do_lag: lag 0x1 = 10.1 (14.252688)
Sun Nov 27 12:19:29.846 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.846 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.849 2005: do_lag: lag 0x2 = 9.9 (10.866488)
Sun Nov 27 12:19:29.849 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.849 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.851 2005: do_lag: lag 0x3 = -4.9 (13.304339)
Sun Nov 27 12:19:29.851 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.851 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.853 2005: do_lag: lag 1x2 = -5.1 (11.740687)
Sun Nov 27 12:19:29.853 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.853 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.855 2005: do_lag: lag 1x3 = -15.1 (12.864082)
Sun Nov 27 12:19:29.855 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.855 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.857 2005: do_lag: lag 2x3 = -13.2 (10.967057)
Sun Nov 27 12:19:29.857 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.857 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=6.956481
Sun Nov 27 12:19:29.857 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=67.59, phi=4.32, speed=0.006586
Sun Nov 27 12:19:29.857 2005: ar_find_doa2: final offsets are -3.058534, 7.352648, 4.548544, -7.352648
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: correcting for delta of 1.73...
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: correcting for delta of -0.37...
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: delta of -2.78 too large... ignoring xcorr 1x2
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: correcting for delta of -0.21...
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: correcting for delta of -1.08...
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: correcting for delta of -0.72...
Sun Nov 27 12:19:29.858 2005: ar_find_doa2: Found crossing point at index 367 (i.e. 5684.88), conf=6.778941
Sun Nov 27 12:19:29.858 2005: ar_process_chirp: Theta = 67.586197 degrees, phi = 4.323483 degrees, SNR = 1.437508
Sun Nov 27 12:19:29.858 2005: ar_process_chirp: Final answer: 5684.88[conf=6.778941], max value=1087.709473
Sun Nov 27 12:19:29.866 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.866 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.866 2005: process_file: node 0 Recorded distance of 40.322000 [6.700000] from node 0.0.0.100
Sun Nov 27 12:19:29.866 2005: process_file: **** Processing file ar-raw-6923-100-105:
Sun Nov 27 12:19:29.871 2005: process_file: **** Timing error was 5.291502 
Sun Nov 27 12:19:29.871 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8191.90, frac=0.20
Sun Nov 27 12:19:29.906 2005: ar_find_max: Initial mean/stddev: 35.084465/23.515533 (thresh=100)
Sun Nov 27 12:19:29.906 2005: ar_find_max: tracing, index 4299 sig=1656.034180 m/s=66.684654/90.373352
Sun Nov 27 12:19:29.906 2005: ar_find_max:   Max conf is 17.59 (stddev=90.37)
Sun Nov 27 12:19:29.906 2005: ar_find_doa2: Found peak of 1656.034180[18.324364] at 4299, channel 0
Sun Nov 27 12:19:29.906 2005: ar_find_max: Initial mean/stddev: 48.752174/33.397327 (thresh=100)
Sun Nov 27 12:19:29.907 2005: ar_find_max: tracing, index 4286 sig=-1181.146729 m/s=88.896187/87.827324
Sun Nov 27 12:19:29.907 2005: ar_find_max:   Max conf is 12.44 (stddev=87.83)
Sun Nov 27 12:19:29.907 2005: ar_find_doa2: Found peak of 1181.146729[13.448511] at 4286, channel 1
Sun Nov 27 12:19:29.907 2005: ar_find_max: Initial mean/stddev: 49.941490/36.288506 (thresh=100)
Sun Nov 27 12:19:29.908 2005: ar_find_max: tracing, index 4293 sig=2134.288818 m/s=97.350250/145.800232
Sun Nov 27 12:19:29.908 2005: ar_find_max: tracing, index 4294 sig=2512.828613 m/s=97.350250/145.800232
Sun Nov 27 12:19:29.908 2005: ar_find_max:   Max conf is 16.57 (stddev=145.80)
Sun Nov 27 12:19:29.908 2005: ar_find_doa2: Found peak of 2512.828613[17.234737] at 4294, channel 2
Sun Nov 27 12:19:29.908 2005: ar_find_max: Initial mean/stddev: 27.342205/21.355074 (thresh=100)
Sun Nov 27 12:19:29.908 2005: ar_find_max: tracing, index 4303 sig=1646.867676 m/s=71.564293/96.793182
Sun Nov 27 12:19:29.908 2005: ar_find_max:   Max conf is 16.27 (stddev=96.79)
Sun Nov 27 12:19:29.908 2005: ar_find_doa2: Found peak of 1646.867676[17.014294] at 4303, channel 3
Sun Nov 27 12:19:29.913 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.917 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:29.921 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:29.925 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:29.925 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.927 2005: do_lag: lag 0x1 = 11.1 (1730.098145)
Sun Nov 27 12:19:29.927 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:29.927 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:29.929 2005: do_lag: lag 0x2 = 6.1 (1856.037720)
Sun Nov 27 12:19:29.929 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:29.929 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:29.931 2005: do_lag: lag 0x3 = -3.9 (1415.923828)
Sun Nov 27 12:19:29.931 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:29.931 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.934 2005: do_lag: lag 1x2 = -5.1 (1924.897583)
Sun Nov 27 12:19:29.934 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:29.934 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:29.936 2005: do_lag: lag 1x3 = -15.0 (1398.173218)
Sun Nov 27 12:19:29.936 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:29.936 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:29.938 2005: do_lag: lag 2x3 = -9.9 (1588.461304)
Sun Nov 27 12:19:29.938 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:29.938 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=14.271884
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=70.98, phi=356.70, speed=0.006769
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: final offsets are -3.492553, 7.167216, 2.354004, -7.167216
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: correcting for delta of -0.48...
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: correcting for delta of 0.03...
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: correcting for delta of -0.11...
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: correcting for delta of 0.19...
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: correcting for delta of 0.11...
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: correcting for delta of -0.09...
Sun Nov 27 12:19:29.939 2005: ar_find_doa2: Found crossing point at index 336 (i.e. 4296.00), conf=22.738792
Sun Nov 27 12:19:29.939 2005: ar_process_chirp: Theta = 70.979767 degrees, phi = 356.697632 degrees, SNR = 0.700678
Sun Nov 27 12:19:29.939 2005: ar_process_chirp: Final answer: 4296.00[conf=22.738792], max value=18617.162109
Sun Nov 27 12:19:29.945 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:29.945 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:29.945 2005: process_file: node 0 Recorded distance of 30.301000 [22.700000] from node 0.0.0.100
Sun Nov 27 12:19:29.946 2005: process_file: **** Processing file ar-raw-6923-100-104:
Sun Nov 27 12:19:29.950 2005: process_file: **** Timing error was 2.000000 
Sun Nov 27 12:19:29.950 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8191.85, frac=0.85
Sun Nov 27 12:19:29.984 2005: ar_find_max: Initial mean/stddev: 17.601671/11.888817 (thresh=100)
Sun Nov 27 12:19:29.984 2005: ar_find_max: tracing, index 6441 sig=783.876343 m/s=39.060749/43.971569
Sun Nov 27 12:19:29.984 2005: ar_find_max:   Max conf is 16.94 (stddev=43.97)
Sun Nov 27 12:19:29.984 2005: ar_find_doa2: Found peak of 783.876343[17.826890] at 6441, channel 0
Sun Nov 27 12:19:29.984 2005: ar_find_max: Initial mean/stddev: 23.241533/17.250389 (thresh=100)
Sun Nov 27 12:19:29.985 2005: ar_find_max: tracing, index 6432 sig=821.996094 m/s=56.342991/55.229870
Sun Nov 27 12:19:29.985 2005: ar_find_max: tracing, index 6433 sig=1304.910522 m/s=56.342991/55.229870
Sun Nov 27 12:19:29.985 2005: ar_find_max:   Max conf is 22.61 (stddev=55.23)
Sun Nov 27 12:19:29.985 2005: ar_find_doa2: Found peak of 1304.910522[23.626898] at 6433, channel 1
Sun Nov 27 12:19:29.985 2005: ar_find_max: Initial mean/stddev: 9.309459/6.720929 (thresh=100)
Sun Nov 27 12:19:29.986 2005: ar_find_max: tracing, index 6439 sig=517.779846 m/s=24.815903/29.938540
Sun Nov 27 12:19:29.986 2005: ar_find_max: tracing, index 6440 sig=592.433716 m/s=24.815903/29.938540
Sun Nov 27 12:19:29.986 2005: ar_find_max:   Max conf is 18.96 (stddev=29.94)
Sun Nov 27 12:19:29.986 2005: ar_find_doa2: Found peak of 592.433716[19.788331] at 6440, channel 2
Sun Nov 27 12:19:29.986 2005: ar_find_max: Initial mean/stddev: 9.977511/7.445227 (thresh=100)
Sun Nov 27 12:19:29.987 2005: ar_find_max: tracing, index 6449 sig=539.752747 m/s=26.237555/30.018457
Sun Nov 27 12:19:29.987 2005: ar_find_max:   Max conf is 17.11 (stddev=30.02)
Sun Nov 27 12:19:29.987 2005: ar_find_doa2: Found peak of 539.752747[17.980696] at 6449, channel 3
Sun Nov 27 12:19:29.991 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:29.998 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.003 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.007 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.007 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.009 2005: do_lag: lag 0x1 = 8.5 (250.830719)
Sun Nov 27 12:19:30.009 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.009 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.011 2005: do_lag: lag 0x2 = 1.6 (212.261627)
Sun Nov 27 12:19:30.011 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.011 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.013 2005: do_lag: lag 0x3 = -7.9 (266.780334)
Sun Nov 27 12:19:30.013 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.013 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.015 2005: do_lag: lag 1x2 = -6.9 (228.677277)
Sun Nov 27 12:19:30.015 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.015 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.017 2005: do_lag: lag 1x3 = -16.4 (284.778931)
Sun Nov 27 12:19:30.017 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.017 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.020 2005: do_lag: lag 2x3 = -9.5 (217.352280)
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: estimate theta=15.00, phi=15.00, min_error=16.014114
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=47.15, phi=2.94, speed=0.006895
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: final offsets are -0.299054, 7.969995, 1.314334, -7.969995
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: correcting for delta of 0.01...
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: correcting for delta of -0.16...
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: correcting for delta of -0.24...
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: correcting for delta of 0.09...
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: correcting for delta of -0.16...
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: correcting for delta of -0.10...
Sun Nov 27 12:19:30.020 2005: ar_find_doa2: Found crossing point at index 320 (i.e. 6441.00), conf=20.353645
Sun Nov 27 12:19:30.020 2005: ar_process_chirp: Theta = 47.148872 degrees, phi = 2.944486 degrees, SNR = 0.624449
Sun Nov 27 12:19:30.020 2005: ar_process_chirp: Final answer: 6441.00[conf=20.353645], max value=7380.268555
Sun Nov 27 12:19:30.029 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.029 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.029 2005: process_file: node 0 Recorded distance of 45.777000 [20.300000] from node 0.0.0.100
Sun Nov 27 12:19:30.029 2005: process_file: **** Processing file ar-raw-6923-100-110:
Sun Nov 27 12:19:30.032 2005: process_file: **** unable to open file ar-raw-6923-100-110: No such file or directory
Sun Nov 27 12:19:30.032 2005: process_file: **** Processing file ar-raw-6923-100-111:
Sun Nov 27 12:19:30.035 2005: process_file: **** unable to open file ar-raw-6923-100-111: No such file or directory
Sun Nov 27 12:19:30.035 2005: process_file: **** Processing file ar-raw-6923-100-106:
Sun Nov 27 12:19:30.038 2005: process_file: **** Timing error was 5.196152 
Sun Nov 27 12:19:30.038 2005: ar_process_chirp: Beginning new chirp [1]: seed=663, mod=0, obslen=8191.85, frac=0.55
Sun Nov 27 12:19:30.071 2005: ar_find_max: Initial mean/stddev: 4.892615/3.733940 (thresh=100)
Sun Nov 27 12:19:30.072 2005: ar_find_max: tracing, index 8799 sig=291.829224 m/s=18.443960/20.874546
Sun Nov 27 12:19:30.072 2005: ar_find_max: tracing, index 8800 sig=309.522400 m/s=18.443960/20.874546
Sun Nov 27 12:19:30.072 2005: ar_find_max:   Max conf is 13.94 (stddev=20.87)
Sun Nov 27 12:19:30.072 2005: ar_find_doa2: Found peak of 309.522400[14.827743] at 8800, channel 0
Sun Nov 27 12:19:30.072 2005: ar_find_max: Initial mean/stddev: 5.613362/3.965820 (thresh=100)
Sun Nov 27 12:19:30.074 2005: ar_find_max:   Max conf is 11.10 (stddev=4.58)
Sun Nov 27 12:19:30.074 2005: ar_find_max: Initial mean/stddev: 5.538046/3.697993 (thresh=100)
Sun Nov 27 12:19:30.075 2005: ar_find_max: tracing, index 8788 sig=523.408020 m/s=26.771542/38.936897
Sun Nov 27 12:19:30.075 2005: ar_find_max:   Max conf is 12.75 (stddev=38.94)
Sun Nov 27 12:19:30.075 2005: ar_find_doa2: Found peak of 523.408020[13.442469] at 8788, channel 2
Sun Nov 27 12:19:30.075 2005: ar_find_max: Initial mean/stddev: 6.812114/4.783127 (thresh=100)
Sun Nov 27 12:19:30.076 2005: ar_find_max: tracing, index 8801 sig=782.421021 m/s=40.480114/56.848412
Sun Nov 27 12:19:30.076 2005: ar_find_max:   Max conf is 13.05 (stddev=56.85)
Sun Nov 27 12:19:30.076 2005: ar_find_doa2: Found peak of 782.421021[13.763287] at 8801, channel 3
Sun Nov 27 12:19:30.081 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.085 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.089 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.095 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.095 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.097 2005: do_lag: lag 0x1 = 12.1 (137.164658)
Sun Nov 27 12:19:30.097 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.097 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.099 2005: do_lag: lag 0x2 = 11.8 (140.966049)
Sun Nov 27 12:19:30.099 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.099 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.101 2005: do_lag: lag 0x3 = -1.1 (127.876846)
Sun Nov 27 12:19:30.101 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.101 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.103 2005: do_lag: lag 1x2 = -0.4 (167.269913)
Sun Nov 27 12:19:30.103 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.103 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.105 2005: do_lag: lag 1x3 = -13.4 (159.978714)
Sun Nov 27 12:19:30.105 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.105 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.108 2005: do_lag: lag 2x3 = -13.0 (171.890961)
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=10.543208
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=84.39, phi=2.27, speed=0.006545
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: final offsets are -5.064208, 6.167066, 5.845437, -6.167066
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: correcting for delta of -0.02...
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: correcting for delta of 0.72...
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: correcting for delta of 0.40...
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: correcting for delta of -0.63...
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: correcting for delta of 0.41...
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: correcting for delta of -0.26...
Sun Nov 27 12:19:30.108 2005: ar_find_doa2: Found crossing point at index 306 (i.e. 8794.25), conf=20.213959
Sun Nov 27 12:19:30.108 2005: ar_process_chirp: Theta = 84.391800 degrees, phi = 2.265292 degrees, SNR = 0.948478
Sun Nov 27 12:19:30.108 2005: ar_process_chirp: Final answer: 8794.25[conf=20.213959], max value=5568.268555
Sun Nov 27 12:19:30.120 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.120 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.120 2005: process_file: node 0 Recorded distance of 62.763000 [20.200000] from node 0.0.0.100
Sun Nov 27 12:19:30.120 2005: process_file: **** Processing file ar-raw-6923-100-109:
Sun Nov 27 12:19:30.122 2005: process_file: **** unable to open file ar-raw-6923-100-109: No such file or directory
Sun Nov 27 12:19:30.123 2005: process_file: **** Processing file ar-raw-6924-100-100:
Sun Nov 27 12:19:30.126 2005: process_file: **** Orig dist was 321.250000 
Sun Nov 27 12:19:30.126 2005: process_file: **** Timing error was 6.395311 
Sun Nov 27 12:19:30.126 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8192.00, frac=0.05
Sun Nov 27 12:19:30.142 2005: ar_process_chirp: subsample ifft'd local recording
Sun Nov 27 12:19:30.142 2005: ar_process_chirp: ***Selfrange average = 6459.577148, frac over = 127.669693
Sun Nov 27 12:19:30.142 2005: ar_process_chirp: Final answer: 326.88[conf=127.669693], max value=824692.250000
Sun Nov 27 12:19:30.142 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.143 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.143 2005: process_file: node 100 Recorded distance of 1.656000 [127.600000] from node 0.0.0.100
Sun Nov 27 12:19:30.143 2005: main: **** OFFSET=5!!!
Sun Nov 27 12:19:30.143 2005: process_file: **** Processing file ar-raw-6924-100-103:
Sun Nov 27 12:19:30.146 2005: process_file: **** Timing error was 5.495453 
Sun Nov 27 12:19:30.146 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8191.85, frac=0.45
Sun Nov 27 12:19:30.179 2005: ar_find_max: Initial mean/stddev: 110.467606/69.550240 (thresh=100)
Sun Nov 27 12:19:30.179 2005: ar_find_max: tracing, index 3101 sig=-1608.669800 m/s=126.331902/104.953667
Sun Nov 27 12:19:30.180 2005: ar_find_max:   Max conf is 14.12 (stddev=104.95)
Sun Nov 27 12:19:30.180 2005: ar_find_doa2: Found peak of 1608.669800[15.327428] at 3101, channel 0
Sun Nov 27 12:19:30.180 2005: ar_find_max: Initial mean/stddev: 148.817535/95.104485 (thresh=100)
Sun Nov 27 12:19:30.180 2005: ar_find_max: tracing, index 3089 sig=-2217.807617 m/s=172.906586/156.047089
Sun Nov 27 12:19:30.180 2005: ar_find_max:   Max conf is 13.10 (stddev=156.05)
Sun Nov 27 12:19:30.180 2005: ar_find_doa2: Found peak of 2217.807617[14.212425] at 3089, channel 1
Sun Nov 27 12:19:30.180 2005: ar_find_max: Initial mean/stddev: 210.402649/162.013168 (thresh=100)
Sun Nov 27 12:19:30.180 2005: ar_find_max: tracing, index 3089 sig=-5277.068359 m/s=308.827789/284.898468
Sun Nov 27 12:19:30.180 2005: ar_find_max:   Max conf is 17.44 (stddev=284.90)
Sun Nov 27 12:19:30.180 2005: ar_find_doa2: Found peak of 5277.068359[18.522628] at 3089, channel 2
Sun Nov 27 12:19:30.180 2005: ar_find_max: Initial mean/stddev: 143.996429/107.618843 (thresh=100)
Sun Nov 27 12:19:30.181 2005: ar_find_max: tracing, index 3101 sig=-2968.477539 m/s=190.403992/151.564377
Sun Nov 27 12:19:30.181 2005: ar_find_max:   Max conf is 18.33 (stddev=151.56)
Sun Nov 27 12:19:30.181 2005: ar_find_doa2: Found peak of 2968.477539[19.585589] at 3101, channel 3
Sun Nov 27 12:19:30.185 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.190 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.196 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.200 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.200 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.202 2005: do_lag: lag 0x1 = 11.8 (10325.703125)
Sun Nov 27 12:19:30.202 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.202 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.204 2005: do_lag: lag 0x2 = 12.5 (11734.388672)
Sun Nov 27 12:19:30.204 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.204 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.206 2005: do_lag: lag 0x3 = 0.2 (11636.124023)
Sun Nov 27 12:19:30.206 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.206 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.208 2005: do_lag: lag 1x2 = 0.6 (13527.101562)
Sun Nov 27 12:19:30.208 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.208 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.210 2005: do_lag: lag 1x3 = -11.6 (12589.215820)
Sun Nov 27 12:19:30.210 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.210 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.212 2005: do_lag: lag 2x3 = -12.2 (14480.633789)
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=15.037133
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=91.07, phi=1.39, speed=0.006766
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: final offsets are -5.749767, 5.539069, 6.228699, -5.539069
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: correcting for delta of 0.33...
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: correcting for delta of -0.10...
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: correcting for delta of 0.33...
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: correcting for delta of -0.29...
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: correcting for delta of 0.07...
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: correcting for delta of -0.09...
Sun Nov 27 12:19:30.213 2005: ar_find_doa2: Found crossing point at index 322 (i.e. 3097.25), conf=18.695848
Sun Nov 27 12:19:30.213 2005: ar_process_chirp: Theta = 91.069260 degrees, phi = 1.388509 degrees, SNR = 0.665020
Sun Nov 27 12:19:30.213 2005: ar_process_chirp: Final answer: 3097.25[conf=18.695848], max value=46520.109375
Sun Nov 27 12:19:30.218 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.218 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.218 2005: process_file: node 0 Recorded distance of 21.648000 [18.600000] from node 0.0.0.100
Sun Nov 27 12:19:30.218 2005: process_file: **** Processing file ar-raw-6924-100-102:
Sun Nov 27 12:19:30.223 2005: process_file: **** Timing error was 3.687818 
Sun Nov 27 12:19:30.223 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8191.80, frac=0.45
Sun Nov 27 12:19:30.256 2005: ar_find_max: Initial mean/stddev: 40.731789/29.598396 (thresh=100)
Sun Nov 27 12:19:30.257 2005: ar_find_max: tracing, index 5099 sig=805.858276 m/s=75.701141/58.377048
Sun Nov 27 12:19:30.257 2005: ar_find_max: tracing, index 5100 sig=1106.225342 m/s=75.701141/58.377048
Sun Nov 27 12:19:30.257 2005: ar_find_max:   Max conf is 17.65 (stddev=58.38)
Sun Nov 27 12:19:30.257 2005: ar_find_doa2: Found peak of 1106.225342[18.949662] at 5100, channel 0
Sun Nov 27 12:19:30.257 2005: ar_find_max: Initial mean/stddev: 48.027977/39.591469 (thresh=100)
Sun Nov 27 12:19:30.259 2005: ar_find_max:   Max conf is 11.24 (stddev=26.78)
Sun Nov 27 12:19:30.259 2005: ar_find_max: Initial mean/stddev: 46.138531/33.787773 (thresh=100)
Sun Nov 27 12:19:30.259 2005: ar_find_max: tracing, index 5085 sig=2132.368164 m/s=104.054489/167.632965
Sun Nov 27 12:19:30.259 2005: ar_find_max:   Max conf is 12.10 (stddev=167.63)
Sun Nov 27 12:19:30.259 2005: ar_find_doa2: Found peak of 2132.368164[12.720458] at 5085, channel 2
Sun Nov 27 12:19:30.259 2005: ar_find_max: Initial mean/stddev: 53.848946/39.416725 (thresh=100)
Sun Nov 27 12:19:30.260 2005: ar_find_max: tracing, index 5100 sig=-1308.581543 m/s=93.114487/77.511124
Sun Nov 27 12:19:30.260 2005: ar_find_max:   Max conf is 15.68 (stddev=77.51)
Sun Nov 27 12:19:30.260 2005: ar_find_doa2: Found peak of 1308.581543[16.882500] at 5100, channel 3
Sun Nov 27 12:19:30.264 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.268 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.273 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.277 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.277 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.278 2005: do_lag: lag 0x1 = 12.0 (2523.152344)
Sun Nov 27 12:19:30.278 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.278 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.281 2005: do_lag: lag 0x2 = 15.1 (2495.933350)
Sun Nov 27 12:19:30.281 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.281 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.283 2005: do_lag: lag 0x3 = -3.5 (1787.750244)
Sun Nov 27 12:19:30.283 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.283 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.285 2005: do_lag: lag 1x2 = 3.1 (3162.314697)
Sun Nov 27 12:19:30.285 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.285 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.287 2005: do_lag: lag 1x3 = -15.5 (2119.391357)
Sun Nov 27 12:19:30.287 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.287 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.289 2005: do_lag: lag 2x3 = -18.6 (2103.531982)
Sun Nov 27 12:19:30.289 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.289 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=14.456626
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=73.72, phi=16.97, speed=0.006123
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: final offsets are -3.669904, 6.698817, 9.440237, -6.698817
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: correcting for delta of -0.27...
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: correcting for delta of -1.57...
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: correcting for delta of -0.80...
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: correcting for delta of 1.08...
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: correcting for delta of 0.66...
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: correcting for delta of -0.21...
Sun Nov 27 12:19:30.290 2005: ar_find_doa2: Found crossing point at index 338 (i.e. 5095.25), conf=16.572006
Sun Nov 27 12:19:30.290 2005: ar_process_chirp: Theta = 73.715851 degrees, phi = 16.974819 degrees, SNR = 0.691724
Sun Nov 27 12:19:30.290 2005: ar_process_chirp: Final answer: 5095.25[conf=16.572006], max value=18098.132812
Sun Nov 27 12:19:30.299 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.299 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.299 2005: process_file: node 0 Recorded distance of 36.067000 [16.500000] from node 0.0.0.100
Sun Nov 27 12:19:30.299 2005: process_file: **** Processing file ar-raw-6924-100-108:
Sun Nov 27 12:19:30.303 2005: process_file: **** Timing error was 6.099180 
Sun Nov 27 12:19:30.304 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8191.80, frac=0.40
Sun Nov 27 12:19:30.337 2005: ar_find_max: Initial mean/stddev: 5.243238/4.136310 (thresh=100)
Sun Nov 27 12:19:30.338 2005: ar_find_max: tracing, index 5688 sig=214.997314 m/s=15.991378/13.281546
Sun Nov 27 12:19:30.338 2005: ar_find_max:   Max conf is 14.98 (stddev=13.28)
Sun Nov 27 12:19:30.338 2005: ar_find_doa2: Found peak of 214.997314[16.187673] at 5688, channel 0
Sun Nov 27 12:19:30.338 2005: ar_find_max: Initial mean/stddev: 1.802968/1.339835 (thresh=100)
Sun Nov 27 12:19:30.339 2005: ar_find_max: tracing, index 5677 sig=51.907669 m/s=4.188956/3.230867
Sun Nov 27 12:19:30.339 2005: ar_find_max: tracing, index 5678 sig=76.491196 m/s=4.188956/3.230867
Sun Nov 27 12:19:30.339 2005: ar_find_max:   Max conf is 22.38 (stddev=3.23)
Sun Nov 27 12:19:30.339 2005: ar_find_doa2: Found peak of 76.491196[23.675132] at 5678, channel 1
Sun Nov 27 12:19:30.339 2005: ar_find_max: Initial mean/stddev: 7.560029/6.184275 (thresh=100)
Sun Nov 27 12:19:30.339 2005: ar_find_max: tracing, index 5681 sig=240.383545 m/s=16.512501/16.816420
Sun Nov 27 12:19:30.339 2005: ar_find_max:   Max conf is 13.31 (stddev=16.82)
Sun Nov 27 12:19:30.340 2005: ar_find_doa2: Found peak of 240.383545[14.294573] at 5681, channel 2
Sun Nov 27 12:19:30.340 2005: ar_find_max: Initial mean/stddev: 7.646871/5.999065 (thresh=100)
Sun Nov 27 12:19:30.340 2005: ar_find_max: tracing, index 5693 sig=211.530853 m/s=18.094500/13.280269
Sun Nov 27 12:19:30.340 2005: ar_find_max:   Max conf is 14.57 (stddev=13.28)
Sun Nov 27 12:19:30.340 2005: ar_find_doa2: Found peak of 211.530853[15.928206] at 5693, channel 3
Sun Nov 27 12:19:30.344 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.349 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.353 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.357 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.357 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.359 2005: do_lag: lag 0x1 = 10.2 (16.494446)
Sun Nov 27 12:19:30.359 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.359 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.361 2005: do_lag: lag 0x2 = 6.0 (9.089407)
Sun Nov 27 12:19:30.361 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.361 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.363 2005: do_lag: lag 0x3 = -5.0 (9.232532)
Sun Nov 27 12:19:30.363 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.363 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.365 2005: do_lag: lag 1x2 = -4.4 (14.453347)
Sun Nov 27 12:19:30.365 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.365 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.367 2005: do_lag: lag 1x3 = -15.2 (9.601221)
Sun Nov 27 12:19:30.367 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.367 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.370 2005: do_lag: lag 2x3 = -12.4 (7.128556)
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=7.454245
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=62.74, phi=3.56, speed=0.006894
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: final offsets are -2.428340, 7.591827, 3.655486, -7.591827
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: correcting for delta of -0.49...
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: correcting for delta of -0.18...
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: correcting for delta of 0.28...
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: correcting for delta of 0.02...
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: correcting for delta of -0.53...
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: correcting for delta of -0.07...
Sun Nov 27 12:19:30.370 2005: ar_find_doa2: Found crossing point at index 316 (i.e. 5685.50), conf=7.083730
Sun Nov 27 12:19:30.370 2005: ar_process_chirp: Theta = 62.737522 degrees, phi = 3.559654 degrees, SNR = 1.341518
Sun Nov 27 12:19:30.370 2005: ar_process_chirp: Final answer: 5685.50[conf=7.083730], max value=1347.754395
Sun Nov 27 12:19:30.378 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.378 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.379 2005: process_file: node 0 Recorded distance of 40.328000 [7.000000] from node 0.0.0.100
Sun Nov 27 12:19:30.379 2005: process_file: **** Processing file ar-raw-6924-100-105:
Sun Nov 27 12:19:30.383 2005: process_file: **** Timing error was 4.795832 
Sun Nov 27 12:19:30.383 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8192.00, frac=0.30
Sun Nov 27 12:19:30.418 2005: ar_find_max: Initial mean/stddev: 29.126427/21.527935 (thresh=100)
Sun Nov 27 12:19:30.419 2005: ar_find_max: tracing, index 4305 sig=1467.054565 m/s=78.948792/81.380150
Sun Nov 27 12:19:30.419 2005: ar_find_max: tracing, index 4306 sig=1601.477783 m/s=78.948792/81.380150
Sun Nov 27 12:19:30.419 2005: ar_find_max:   Max conf is 18.71 (stddev=81.38)
Sun Nov 27 12:19:30.419 2005: ar_find_doa2: Found peak of 1601.477783[19.678973] at 4306, channel 0
Sun Nov 27 12:19:30.419 2005: ar_find_max: Initial mean/stddev: 37.745758/27.913065 (thresh=100)
Sun Nov 27 12:19:30.419 2005: ar_find_max: tracing, index 4294 sig=2119.573975 m/s=98.902290/112.992264
Sun Nov 27 12:19:30.419 2005: ar_find_max:   Max conf is 17.88 (stddev=112.99)
Sun Nov 27 12:19:30.419 2005: ar_find_doa2: Found peak of 2119.573975[18.758576] at 4294, channel 1
Sun Nov 27 12:19:30.420 2005: ar_find_max: Initial mean/stddev: 35.739212/29.833025 (thresh=100)
Sun Nov 27 12:19:30.421 2005: ar_find_max:   Max conf is 11.85 (stddev=39.21)
Sun Nov 27 12:19:30.421 2005: ar_find_max: Initial mean/stddev: 26.428701/16.451458 (thresh=100)
Sun Nov 27 12:19:30.422 2005: ar_find_max: tracing, index 4309 sig=1412.960083 m/s=68.966652/83.219261
Sun Nov 27 12:19:30.422 2005: ar_find_max: tracing, index 4310 sig=1613.771729 m/s=68.966652/83.219261
Sun Nov 27 12:19:30.422 2005: ar_find_max:   Max conf is 18.56 (stddev=83.22)
Sun Nov 27 12:19:30.422 2005: ar_find_doa2: Found peak of 1613.771729[19.391806] at 4310, channel 3
Sun Nov 27 12:19:30.426 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.430 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.435 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.439 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.439 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.440 2005: do_lag: lag 0x1 = 11.2 (1644.632690)
Sun Nov 27 12:19:30.440 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.440 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.443 2005: do_lag: lag 0x2 = 6.0 (1646.058838)
Sun Nov 27 12:19:30.443 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.443 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.444 2005: do_lag: lag 0x3 = -3.9 (1376.829468)
Sun Nov 27 12:19:30.444 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.445 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.447 2005: do_lag: lag 1x2 = -5.2 (1961.982056)
Sun Nov 27 12:19:30.447 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.447 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.449 2005: do_lag: lag 1x3 = -15.1 (1584.464722)
Sun Nov 27 12:19:30.449 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.449 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.451 2005: do_lag: lag 2x3 = -9.9 (1614.322876)
Sun Nov 27 12:19:30.451 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.451 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=14.175402
Sun Nov 27 12:19:30.451 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=70.96, phi=356.39, speed=0.006712
Sun Nov 27 12:19:30.451 2005: ar_find_doa2: final offsets are -3.489239, 7.165997, 2.246259, -7.165997
Sun Nov 27 12:19:30.451 2005: ar_find_doa2: correcting for delta of -0.14...
Sun Nov 27 12:19:30.452 2005: ar_find_doa2: correcting for delta of -0.58...
Sun Nov 27 12:19:30.452 2005: ar_find_doa2: correcting for delta of -0.08...
Sun Nov 27 12:19:30.452 2005: ar_find_doa2: correcting for delta of 0.31...
Sun Nov 27 12:19:30.452 2005: ar_find_doa2: correcting for delta of 0.11...
Sun Nov 27 12:19:30.452 2005: ar_find_doa2: correcting for delta of 0.02...
Sun Nov 27 12:19:30.452 2005: ar_find_doa2: Found crossing point at index 320 (i.e. 4302.00), conf=19.238642
Sun Nov 27 12:19:30.452 2005: ar_process_chirp: Theta = 70.962196 degrees, phi = 356.394348 degrees, SNR = 0.705447
Sun Nov 27 12:19:30.452 2005: ar_process_chirp: Final answer: 4302.00[conf=19.238642], max value=17944.605469
Sun Nov 27 12:19:30.458 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.458 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.458 2005: process_file: node 0 Recorded distance of 30.343000 [19.200000] from node 0.0.0.100
Sun Nov 27 12:19:30.458 2005: process_file: **** Processing file ar-raw-6924-100-104:
Sun Nov 27 12:19:30.463 2005: process_file: **** Timing error was 5.495453 
Sun Nov 27 12:19:30.463 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8191.90, frac=0.55
Sun Nov 27 12:19:30.496 2005: ar_find_max: Initial mean/stddev: 10.879110/7.956995 (thresh=100)
Sun Nov 27 12:19:30.497 2005: ar_find_max: tracing, index 6449 sig=346.899750 m/s=27.572903/24.186731
Sun Nov 27 12:19:30.497 2005: ar_find_max: tracing, index 6450 sig=702.090210 m/s=27.572903/24.186731
Sun Nov 27 12:19:30.497 2005: ar_find_max:   Max conf is 27.89 (stddev=24.19)
Sun Nov 27 12:19:30.497 2005: ar_find_doa2: Found peak of 702.090210[29.027908] at 6450, channel 0
Sun Nov 27 12:19:30.497 2005: ar_find_max: Initial mean/stddev: 20.270714/15.126566 (thresh=100)
Sun Nov 27 12:19:30.500 2005: ar_find_max: tracing, index 6441 sig=749.895630 m/s=55.432137/44.565231
Sun Nov 27 12:19:30.500 2005: ar_find_max: tracing, index 6442 sig=1122.048584 m/s=55.432137/44.565231
Sun Nov 27 12:19:30.500 2005: ar_find_max:   Max conf is 23.93 (stddev=44.57)
Sun Nov 27 12:19:30.500 2005: ar_find_doa2: Found peak of 1122.048584[25.177668] at 6442, channel 1
Sun Nov 27 12:19:30.500 2005: ar_find_max: Initial mean/stddev: 8.379651/5.761442 (thresh=100)
Sun Nov 27 12:19:30.501 2005: ar_find_max: tracing, index 6448 sig=490.293732 m/s=24.754692/24.945261
Sun Nov 27 12:19:30.501 2005: ar_find_max: tracing, index 6449 sig=630.555664 m/s=24.754692/24.945261
Sun Nov 27 12:19:30.501 2005: ar_find_max:   Max conf is 24.29 (stddev=24.95)
Sun Nov 27 12:19:30.501 2005: ar_find_doa2: Found peak of 630.555664[25.277573] at 6449, channel 2
Sun Nov 27 12:19:30.501 2005: ar_find_max: Initial mean/stddev: 8.754362/5.983537 (thresh=100)
Sun Nov 27 12:19:30.502 2005: ar_find_max: tracing, index 6458 sig=475.601501 m/s=23.285063/25.236872
Sun Nov 27 12:19:30.502 2005: ar_find_max:   Max conf is 17.92 (stddev=25.24)
Sun Nov 27 12:19:30.502 2005: ar_find_doa2: Found peak of 475.601501[18.845501] at 6458, channel 3
Sun Nov 27 12:19:30.506 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.510 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.514 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.519 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.519 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.520 2005: do_lag: lag 0x1 = 8.5 (208.073349)
Sun Nov 27 12:19:30.520 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.520 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.523 2005: do_lag: lag 0x2 = 1.5 (200.649734)
Sun Nov 27 12:19:30.523 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.523 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.524 2005: do_lag: lag 0x3 = -8.0 (233.299820)
Sun Nov 27 12:19:30.524 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.524 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.527 2005: do_lag: lag 1x2 = -7.0 (219.037109)
Sun Nov 27 12:19:30.527 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.527 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.529 2005: do_lag: lag 1x3 = -16.4 (270.958588)
Sun Nov 27 12:19:30.529 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.529 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.531 2005: do_lag: lag 2x3 = -9.5 (224.047165)
Sun Nov 27 12:19:30.531 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.531 2005: ar_find_doa2: estimate theta=15.00, phi=15.00, min_error=15.159184
Sun Nov 27 12:19:30.531 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=46.69, phi=2.94, speed=0.006873
Sun Nov 27 12:19:30.531 2005: ar_find_doa2: final offsets are -0.235889, 7.972128, 1.250484, -7.972128
Sun Nov 27 12:19:30.531 2005: ar_find_doa2: correcting for delta of 0.01...
Sun Nov 27 12:19:30.531 2005: ar_find_doa2: correcting for delta of 0.22...
Sun Nov 27 12:19:30.532 2005: ar_find_doa2: correcting for delta of -0.14...
Sun Nov 27 12:19:30.532 2005: ar_find_doa2: correcting for delta of -0.28...
Sun Nov 27 12:19:30.532 2005: ar_find_doa2: correcting for delta of -0.20...
Sun Nov 27 12:19:30.532 2005: ar_find_doa2: correcting for delta of -0.01...
Sun Nov 27 12:19:30.532 2005: ar_find_doa2: Found crossing point at index 320 (i.e. 6450.00), conf=18.478739
Sun Nov 27 12:19:30.532 2005: ar_process_chirp: Theta = 46.694839 degrees, phi = 2.942497 degrees, SNR = 0.659666
Sun Nov 27 12:19:30.532 2005: ar_process_chirp: Final answer: 6450.00[conf=18.478739], max value=7142.164551
Sun Nov 27 12:19:30.540 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.540 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.541 2005: process_file: node 0 Recorded distance of 45.844000 [18.400000] from node 0.0.0.100
Sun Nov 27 12:19:30.541 2005: process_file: **** Processing file ar-raw-6924-100-110:
Sun Nov 27 12:19:30.543 2005: process_file: **** unable to open file ar-raw-6924-100-110: No such file or directory
Sun Nov 27 12:19:30.543 2005: process_file: **** Processing file ar-raw-6924-100-111:
Sun Nov 27 12:19:30.546 2005: process_file: **** unable to open file ar-raw-6924-100-111: No such file or directory
Sun Nov 27 12:19:30.546 2005: process_file: **** Processing file ar-raw-6924-100-106:
Sun Nov 27 12:19:30.549 2005: process_file: **** Timing error was 6.000000 
Sun Nov 27 12:19:30.549 2005: ar_process_chirp: Beginning new chirp [1]: seed=505, mod=0, obslen=8191.90, frac=0.45
Sun Nov 27 12:19:30.583 2005: ar_find_max: Initial mean/stddev: 4.015650/2.991836 (thresh=100)
Sun Nov 27 12:19:30.584 2005: ar_find_max: tracing, index 8813 sig=140.247162 m/s=12.445099/10.293653
Sun Nov 27 12:19:30.584 2005: ar_find_max: tracing, index 8814 sig=191.041275 m/s=12.445099/10.293653
Sun Nov 27 12:19:30.584 2005: ar_find_max:   Max conf is 17.35 (stddev=10.29)
Sun Nov 27 12:19:30.584 2005: ar_find_doa2: Found peak of 191.041275[18.559134] at 8814, channel 0
Sun Nov 27 12:19:30.584 2005: ar_find_max: Initial mean/stddev: 4.229614/3.174263 (thresh=100)
Sun Nov 27 12:19:30.586 2005: ar_find_max:   Max conf is 10.31 (stddev=3.97)
Sun Nov 27 12:19:30.586 2005: ar_find_max: Initial mean/stddev: 5.100260/3.883435 (thresh=100)
Sun Nov 27 12:19:30.587 2005: ar_find_max: tracing, index 8802 sig=305.705811 m/s=20.451521/18.138168
Sun Nov 27 12:19:30.587 2005: ar_find_max:   Max conf is 15.73 (stddev=18.14)
Sun Nov 27 12:19:30.587 2005: ar_find_doa2: Found peak of 305.705811[16.854282] at 8802, channel 2
Sun Nov 27 12:19:30.587 2005: ar_find_max: Initial mean/stddev: 4.230718/3.339311 (thresh=100)
Sun Nov 27 12:19:30.588 2005: ar_find_max: tracing, index 8815 sig=381.013428 m/s=24.162737/21.999298
Sun Nov 27 12:19:30.588 2005: ar_find_max:   Max conf is 16.22 (stddev=22.00)
Sun Nov 27 12:19:30.588 2005: ar_find_doa2: Found peak of 381.013428[17.319345] at 8815, channel 3
Sun Nov 27 12:19:30.592 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.596 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.603 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.607 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.607 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.608 2005: do_lag: lag 0x1 = 12.1 (45.654900)
Sun Nov 27 12:19:30.608 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.608 2005: do_lag: testing with slip 243 [30]
Sun Nov 27 12:19:30.611 2005: do_lag: lag 0x2 = 11.9 (44.025764)
Sun Nov 27 12:19:30.611 2005: ar_find_doa2: crosscorrelated channels 0, 2
Sun Nov 27 12:19:30.611 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.612 2005: do_lag: lag 0x3 = -0.9 (45.550514)
Sun Nov 27 12:19:30.613 2005: ar_find_doa2: crosscorrelated channels 0, 3
Sun Nov 27 12:19:30.613 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.615 2005: do_lag: lag 1x2 = -0.4 (56.190041)
Sun Nov 27 12:19:30.615 2005: ar_find_doa2: crosscorrelated channels 1, 2
Sun Nov 27 12:19:30.615 2005: do_lag: testing with slip 167 [20]
Sun Nov 27 12:19:30.617 2005: do_lag: lag 1x3 = -13.4 (56.898293)
Sun Nov 27 12:19:30.617 2005: ar_find_doa2: crosscorrelated channels 1, 3
Sun Nov 27 12:19:30.617 2005: do_lag: testing with slip 222 [27]
Sun Nov 27 12:19:30.620 2005: do_lag: lag 2x3 = -13.0 (65.297768)
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: crosscorrelated channels 2, 3
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: estimate theta=60.00, phi=15.00, min_error=9.856722
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: *&*&*&*&*& POST LSFIT: estimate theta=85.14, phi=1.92, speed=0.006500
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: final offsets are -5.145556, 6.101644, 5.808388, -6.101644
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: correcting for delta of 0.62...
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: correcting for delta of -0.16...
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: correcting for delta of 0.45...
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: correcting for delta of -0.14...
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: correcting for delta of -0.69...
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: correcting for delta of -0.42...
Sun Nov 27 12:19:30.620 2005: ar_find_doa2: Found crossing point at index 308 (i.e. 8808.50), conf=11.879037
Sun Nov 27 12:19:30.620 2005: ar_process_chirp: Theta = 85.141159 degrees, phi = 1.921838 degrees, SNR = 1.014536
Sun Nov 27 12:19:30.620 2005: ar_process_chirp: Final answer: 8808.50[conf=11.879037], max value=3271.339844
Sun Nov 27 12:19:30.632 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.632 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.632 2005: process_file: node 0 Recorded distance of 62.866000 [11.800000] from node 0.0.0.100
Sun Nov 27 12:19:30.632 2005: process_file: **** Processing file ar-raw-6924-100-109:
Sun Nov 27 12:19:30.635 2005: process_file: **** unable to open file ar-raw-6924-100-109: No such file or directory
Sun Nov 27 12:19:30.635 2005: process_file: **** Processing file ar-raw-6099-102-102:
Sun Nov 27 12:19:30.656 2005: process_file: **** Orig dist was 316.375000 
Sun Nov 27 12:19:30.656 2005: process_file: **** Timing error was 3.492850 
Sun Nov 27 12:19:30.656 2005: ar_process_chirp: Beginning new chirp [1]: seed=438, mod=0, obslen=8192.00, frac=0.45
Sun Nov 27 12:19:30.672 2005: ar_process_chirp: subsample ifft'd local recording
Sun Nov 27 12:19:30.672 2005: ar_process_chirp: ***Selfrange average = 5704.012695, frac over = 134.038147
Sun Nov 27 12:19:30.672 2005: ar_process_chirp: Final answer: 322.00[conf=134.038147], max value=764555.250000
Sun Nov 27 12:19:30.672 2005: ar_process_chirp: Freeing memory!
Sun Nov 27 12:19:30.672 2005: ar_process_chirp: Done Freeing memory!
Sun Nov 27 12:19:30.672 2005: process_file: node 102 Recorded distance of 1.618000 [134.000000] from node 0.0.0.102
Sun Nov 27 12:19:30.672 2005: main: **** OFFSET=5!!!
Sun Nov 27 12:19:30.672 2005: process_file: **** Processing file ar-raw-6099-102-100:
Sun Nov 27 12:19:30.703 2005: process_file: **** Timing error was 4.795832 
Sun Nov 27 12:19:30.703 2005: ar_process_chirp: Beginning new chirp [1]: seed=438, mod=0, obslen=8192.20, frac=0.95
Sun Nov 27 12:19:30.737 2005: ar_find_max: Initial mean/stddev: 26.139841/20.136559 (thresh=100)
Sun Nov 27 12:19:30.737 2005: ar_find_max: tracing, index 5083 sig=1475.247803 m/s=57.885059/60.854965
Sun Nov 27 12:19:30.737 2005: ar_find_max:   Max conf is 23.29 (stddev=60.85)
Sun Nov 27 12:19:30.737 2005: ar_find_doa2: Found peak of 1475.247803[24.242029] at 5083, channel 0
Sun Nov 27 12:19:30.737 2005: ar_find_max: Initial mean/stddev: 23.163399/18.256893 (thresh=100)
Sun Nov 27 12:19:30.738 2005: ar_find_max: tracing, index 5093 sig=-614.407349 m/s=50.220409/40.700287
Sun Nov 27 12:19:30.738 2005: ar_find_max:   Max conf is 13.86 (stddev=40.70)
Sun Nov 27 12:19:30.738 2005: ar_find_doa2: Found peak of 614.407349[15.095897] at 5093, channel 1
Sun Nov 27 12:19:30.738 2005: ar_find_max: Initial mean/stddev: 18.036093/13.407795 (thresh=100)
Sun Nov 27 12:19:30.739 2005: ar_find_max: tracing, index 5092 sig=-348.161194 m/s=33.554226/25.720715
Sun Nov 27 12:19:30.739 2005: ar_find_max:   Max conf is 12.23 (stddev=25.72)
Sun Nov 27 12:19:30.739 2005: ar_find_doa2: Found peak of 348.161194[13.536218] at 5092, channel 2
Sun Nov 27 12:19:30.739 2005: ar_find_max: Initial mean/stddev: 19.390053/14.576193 (thresh=100)
Sun Nov 27 12:19:30.739 2005: ar_find_max: tracing, index 5082 sig=620.127197 m/s=37.326508/41.098248
Sun Nov 27 12:19:30.739 2005: ar_find_max: tracing, index 5083 sig=1073.142456 m/s=37.326508/41.098248
Sun Nov 27 12:19:30.739 2005: ar_find_max:   Max conf is 25.20 (stddev=41.10)
Sun Nov 27 12:19:30.739 2005: ar_find_doa2: Found peak of 1073.142456[26.111635] at 5083, channel 3
Sun Nov 27 12:19:30.743 2005: ar_find_doa2: subsample ifft'd channel 0
Sun Nov 27 12:19:30.748 2005: ar_find_doa2: subsample ifft'd channel 1
Sun Nov 27 12:19:30.752 2005: ar_find_doa2: subsample ifft'd channel 2
Sun Nov 27 12:19:30.756 2005: ar_find_doa2: subsample ifft'd channel 3
Sun Nov 27 12:19:30.756 2005: do_lag: testing with slip 130 [16]
Sun Nov 27 12:19:30.758 2005: do_lag: lag 0x1 = -11.8 (869.118286)
Sun Nov 27 12:19:30.758 2005: ar_find_doa2: crosscorrelated channels 0, 1
Sun Nov 27 12:19:30.758 2005: do_lag: testing with slip 243 [30]
Sun