Pooles Cavern. Data Transfer

This program was called automatically via CRON

viz: _GET['cron'] == 'yes'

The CRON job sends its output to the Freshen log file. But if the program is called manually, its output goes only to your browser screen.

Data transfer began at 12:13:01 on 17-Oct-2026

Software version 2.3c. File /home/bcra/public_html/data/freshen.php (last modified 12:32:50 on 23-Mar-2026).
PHP time limit set to 5000 seconds.

Received 9,491 bytes from http://pooles.bcra.org.uk:3927/Exports/

That web page has been mined, and found to have 55 CSV files and 55 JF files to transfer.

$file_list is Array
(
    [0] => all_readings/1000930.csv
    [1] => all_readings/1004463.csv
    [2] => all_readings/1004467.csv
    [3] => all_readings/1008087.csv
    [4] => all_readings/1008089.csv
    [5] => all_readings/1017216.csv
    [6] => all_readings/1017222.csv
    [7] => all_readings/1017223.csv
    [8] => all_readings/1021454.csv
    [9] => all_readings/1046653.csv
    [10] => all_readings/1046676.csv
    [11] => all_readings/1052724.csv
    [12] => all_readings/1052725.csv
    [13] => all_readings/1066279.csv
    [14] => all_readings/790060.csv
    [15] => all_readings/807565.csv
    [16] => all_readings/807566.csv
    [17] => all_readings/819585.csv
    [18] => all_readings/832627.csv
    [19] => all_readings/840298.csv
    [20] => all_readings/840299.csv
    [21] => all_readings/840300.csv
    [22] => all_readings/840301.csv
    [23] => all_readings/840308.csv
    [24] => all_readings/844534.csv
    [25] => all_readings/844555.csv
    [26] => all_readings/859646.csv
    [27] => all_readings/859658.csv
    [28] => all_readings/859669.csv
    [29] => all_readings/865344.csv
    [30] => all_readings/872568.csv
    [31] => all_readings/872642.csv
    [32] => all_readings/879721.csv
    [33] => all_readings/883599.csv
    [34] => all_readings/883600.csv
    [35] => all_readings/883606.csv
    [36] => all_readings/887883.csv
    [37] => all_readings/888271.csv
    [38] => all_readings/888275.csv
    [39] => all_readings/901903.csv
    [40] => all_readings/903422.csv
    [41] => all_readings/904973.csv
    [42] => all_readings/904993.csv
    [43] => all_readings/926759.csv
    [44] => all_readings/929116.csv
    [45] => all_readings/929117.csv
    [46] => all_readings/929128.csv
    [47] => all_readings/929129.csv
    [48] => all_readings/940875.csv
    [49] => all_readings/940877.csv
    [50] => all_readings/942588.csv
    [51] => all_readings/951585.csv
    [52] => all_readings/954903.csv
    [53] => all_readings/954904.csv
    [54] => all_readings/999986.csv
)
$file_list_raw is Array
(
    [0] => Data/current/1000930.jf
    [1] => Data/current/1004463.jf
    [2] => Data/current/1004467.jf
    [3] => Data/current/1008087.jf
    [4] => Data/current/1008089.jf
    [5] => Data/current/1017216.jf
    [6] => Data/current/1017222.jf
    [7] => Data/current/1017223.jf
    [8] => Data/current/1021454.jf
    [9] => Data/current/1046653.jf
    [10] => Data/current/1046676.jf
    [11] => Data/current/1052724.jf
    [12] => Data/current/1052725.jf
    [13] => Data/current/1066279.jf
    [14] => Data/current/790060.jf
    [15] => Data/current/807565.jf
    [16] => Data/current/807566.jf
    [17] => Data/current/819585.jf
    [18] => Data/current/832627.jf
    [19] => Data/current/840298.jf
    [20] => Data/current/840299.jf
    [21] => Data/current/840300.jf
    [22] => Data/current/840301.jf
    [23] => Data/current/840308.jf
    [24] => Data/current/844534.jf
    [25] => Data/current/844555.jf
    [26] => Data/current/859646.jf
    [27] => Data/current/859658.jf
    [28] => Data/current/859669.jf
    [29] => Data/current/865344.jf
    [30] => Data/current/872568.jf
    [31] => Data/current/872642.jf
    [32] => Data/current/879721.jf
    [33] => Data/current/883599.jf
    [34] => Data/current/883600.jf
    [35] => Data/current/883606.jf
    [36] => Data/current/887883.jf
    [37] => Data/current/888271.jf
    [38] => Data/current/888275.jf
    [39] => Data/current/901903.jf
    [40] => Data/current/903422.jf
    [41] => Data/current/904973.jf
    [42] => Data/current/904993.jf
    [43] => Data/current/926759.jf
    [44] => Data/current/929116.jf
    [45] => Data/current/929117.jf
    [46] => Data/current/929128.jf
    [47] => Data/current/929129.jf
    [48] => Data/current/940875.jf
    [49] => Data/current/940877.jf
    [50] => Data/current/942588.jf
    [51] => Data/current/951585.jf
    [52] => Data/current/954903.jf
    [53] => Data/current/954904.jf
    [54] => Data/current/999986.jf
)

Flushed OB. Downloading now. This may take some time...

At 0 seconds (key=0)
  Starting to fetch data
  Fetched 1,168,847 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1000930.csv' in 1 s at rate of 1,168,847 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1000930.csv'
  Process reports that it wrote 1,168,847 bytes. OK.
  Extracted new restart as 365645
  Appended new restart data 365645 to file 'all_readings/1000930.restart.txp'
  Process reports that it wrote 7 bytes. OK.
  (Printed and reset $echo)
At 1 seconds (key=1)
Array key 1 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 1 mod 4 = group 1)

At 1 seconds (key=2)
Array key 2 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 2 mod 4 = group 2)

At 1 seconds (key=3)
Array key 3 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 3 mod 4 = group 3)

At 1 seconds (key=4)
  Starting to fetch data
  Fetched 4,043,616 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1008089.csv' in 2 s at rate of 2,021,808 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1008089.csv'
  Process reports that it wrote 4,043,616 bytes. OK.
  Extracted new restart as 1428389
  Appended new restart data 1428389 to file 'all_readings/1008089.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 3 seconds (key=5)
Array key 5 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 5 mod 4 = group 1)

At 3 seconds (key=6)
Array key 6 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 6 mod 4 = group 2)

At 3 seconds (key=7)
Array key 7 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 7 mod 4 = group 3)

At 3 seconds (key=8)
  Starting to fetch data
  Fetched 4,076,110 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1021454.csv' in 2 s at rate of 2,038,055 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1021454.csv'
  Process reports that it wrote 4,076,110 bytes. OK.
  Extracted new restart as 1308522
  Appended new restart data 1308522 to file 'all_readings/1021454.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 5 seconds (key=9)
Array key 9 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 9 mod 4 = group 1)

At 5 seconds (key=10)
Array key 10 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 10 mod 4 = group 2)

At 5 seconds (key=11)
Array key 11 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 11 mod 4 = group 3)

At 5 seconds (key=12)
  Starting to fetch data
  Fetched 1,563,420 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1052725.csv' in 1 s at rate of 1,563,420 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1052725.csv'
  Process reports that it wrote 1,563,420 bytes. OK.
  Extracted new restart as 487697
  Appended new restart data 487697 to file 'all_readings/1052725.restart.txp'
  Process reports that it wrote 7 bytes. OK.
  (Printed and reset $echo)
At 6 seconds (key=13)
Array key 13 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 13 mod 4 = group 1)

At 6 seconds (key=14)
Array key 14 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 14 mod 4 = group 2)

At 6 seconds (key=15)
Array key 15 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 15 mod 4 = group 3)

At 6 seconds (key=16)
  Starting to fetch data
  Fetched 4,249,023 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/807566.csv' in 3 s at rate of 1,416,341 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/807566.csv'
  Process reports that it wrote 4,249,023 bytes. OK.
  Extracted new restart as 1264700
  Appended new restart data 1264700 to file 'all_readings/807566.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 9 seconds (key=17)
Array key 17 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 17 mod 4 = group 1)

At 9 seconds (key=18)
Array key 18 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 18 mod 4 = group 2)

At 9 seconds (key=19)
Array key 19 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 19 mod 4 = group 3)

At 9 seconds (key=20)
  Starting to fetch data
  Fetched 2,256,573 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/840299.csv' in 2 s at rate of 1,128,287 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/840299.csv'
  Process reports that it wrote 2,256,573 bytes. OK.
  Extracted new restart as 1209345
  Appended new restart data 1209345 to file 'all_readings/840299.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 11 seconds (key=21)
Array key 21 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 21 mod 4 = group 1)

At 11 seconds (key=22)
Array key 22 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 22 mod 4 = group 2)

At 11 seconds (key=23)
Array key 23 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 23 mod 4 = group 3)

At 11 seconds (key=24)
  Starting to fetch data
  Fetched 15,364,569 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/844534.csv' in 8 s at rate of 1,920,571 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/844534.csv'
  Process reports that it wrote 15,364,569 bytes. OK.
  Extracted new restart as 4681528
  Appended new restart data 4681528 to file 'all_readings/844534.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 19 seconds (key=25)
Array key 25 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 25 mod 4 = group 1)

At 19 seconds (key=26)
Array key 26 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 26 mod 4 = group 2)

At 19 seconds (key=27)
Array key 27 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 27 mod 4 = group 3)

At 19 seconds (key=28)
  Starting to fetch data
  Fetched 324,963 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/859669.csv' in 1 s at rate of 324,963 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/859669.csv'
  Process reports that it wrote 324,963 bytes. OK.
  Extracted new restart as 116642
  Appended new restart data 116642 to file 'all_readings/859669.restart.txp'
  Process reports that it wrote 7 bytes. OK.
  (Printed and reset $echo)
At 20 seconds (key=29)
Array key 29 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 29 mod 4 = group 1)

At 20 seconds (key=30)
Array key 30 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 30 mod 4 = group 2)

At 20 seconds (key=31)
Array key 31 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 31 mod 4 = group 3)

At 20 seconds (key=32)
  Starting to fetch data
  Fetched 1,458,483 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/879721.csv' in 1 s at rate of 1,458,483 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/879721.csv'
  Process reports that it wrote 1,458,483 bytes. OK.
  Extracted new restart as 3086017
  Appended new restart data 3086017 to file 'all_readings/879721.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 20 seconds (key=33)
Array key 33 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 33 mod 4 = group 1)

At 20 seconds (key=34)
Array key 34 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 34 mod 4 = group 2)

At 20 seconds (key=35)
Array key 35 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 35 mod 4 = group 3)

At 20 seconds (key=36)
  Starting to fetch data
  Fetched 506,459 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/887883.csv' in 1 s at rate of 506,459 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/887883.csv'
  Process reports that it wrote 506,459 bytes. OK.
  Extracted new restart as 176280
  Appended new restart data 176280 to file 'all_readings/887883.restart.txp'
  Process reports that it wrote 7 bytes. OK.
  (Printed and reset $echo)
At 21 seconds (key=37)
Array key 37 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 37 mod 4 = group 1)

At 21 seconds (key=38)
Array key 38 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 38 mod 4 = group 2)

At 21 seconds (key=39)
Array key 39 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 39 mod 4 = group 3)

At 21 seconds (key=40)
  Starting to fetch data
  Fetched 11,678,674 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/903422.csv' in 6 s at rate of 1,946,446 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/903422.csv'
  Process reports that it wrote 11,678,674 bytes. OK.
  Extracted new restart as 3662816
  Appended new restart data 3662816 to file 'all_readings/903422.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 27 seconds (key=41)
Array key 41 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 41 mod 4 = group 1)

At 27 seconds (key=42)
Array key 42 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 42 mod 4 = group 2)

At 27 seconds (key=43)
Array key 43 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 43 mod 4 = group 3)

At 27 seconds (key=44)
  Starting to fetch data
  Fetched 1,728,414 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/929116.csv' in 1 s at rate of 1,728,414 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/929116.csv'
  Process reports that it wrote 1,728,414 bytes. OK.
  Extracted new restart as 568154
  Appended new restart data 568154 to file 'all_readings/929116.restart.txp'
  Process reports that it wrote 7 bytes. OK.
  (Printed and reset $echo)
At 28 seconds (key=45)
Array key 45 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 45 mod 4 = group 1)

At 28 seconds (key=46)
Array key 46 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 46 mod 4 = group 2)

At 28 seconds (key=47)
Array key 47 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 47 mod 4 = group 3)

At 28 seconds (key=48)
  Starting to fetch data
  Fetched 4,437,591 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/940875.csv' in 2 s at rate of 2,218,796 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/940875.csv'
  Process reports that it wrote 4,437,591 bytes. OK.
  Extracted new restart as 1469069
  Appended new restart data 1469069 to file 'all_readings/940875.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 30 seconds (key=49)
Array key 49 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 49 mod 4 = group 1)

At 30 seconds (key=50)
Array key 50 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 50 mod 4 = group 2)

At 30 seconds (key=51)
Array key 51 skipped. (Time is 12:13. Hour mod 4 is 0, so looking for group 0. But array key 51 mod 4 = group 3)

At 30 seconds (key=52)
  Starting to fetch data
  Fetched 319,735 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/954903.csv' in 1 s at rate of 319,735 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/954903.csv'
  Process reports that it wrote 319,735 bytes. OK.
  Extracted new restart as 91739
  Appended new restart data 91739 to file 'all_readings/954903.restart.txp'
  Process reports that it wrote 6 bytes. OK.
  (Printed and reset $echo)

FINISHED first processing pass. Now looking at *.jf files ...

Now scanning for *.jf files ...

At 31 seconds(key=0)
  Starting to fetch data
  Fetched 369,127 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/1000930.jf' in 1 s at rate of 369,127 B/s
  Saved file to 'all_readings/1000930.jf'
  Process reports that it wrote 369,127 bytes. OK.
  (Printed and reset $echo)
At 31 seconds(key=1)
array key 1 skipped. (Looking for group 0. 1 mod 4 = 1)

At 31 seconds(key=2)
array key 2 skipped. (Looking for group 0. 2 mod 4 = 2)

At 31 seconds(key=3)
array key 3 skipped. (Looking for group 0. 3 mod 4 = 3)

At 31 seconds(key=4)
  Starting to fetch data
  Fetched 1,026,526 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/1008089.jf' in 1 s at rate of 1,026,526 B/s
  Saved file to 'all_readings/1008089.jf'
  Process reports that it wrote 1,026,526 bytes. OK.
  (Printed and reset $echo)
At 32 seconds(key=5)
array key 5 skipped. (Looking for group 0. 5 mod 4 = 1)

At 32 seconds(key=6)
array key 6 skipped. (Looking for group 0. 6 mod 4 = 2)

At 32 seconds(key=7)
array key 7 skipped. (Looking for group 0. 7 mod 4 = 3)

At 32 seconds(key=8)
  Starting to fetch data
  Fetched 1,318,218 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/1021454.jf' in 1 s at rate of 1,318,218 B/s
  Saved file to 'all_readings/1021454.jf'
  Process reports that it wrote 1,318,218 bytes. OK.
  (Printed and reset $echo)
At 32 seconds(key=9)
array key 9 skipped. (Looking for group 0. 9 mod 4 = 1)

At 32 seconds(key=10)
array key 10 skipped. (Looking for group 0. 10 mod 4 = 2)

At 32 seconds(key=11)
array key 11 skipped. (Looking for group 0. 11 mod 4 = 3)

At 32 seconds(key=12)
  Starting to fetch data
  Fetched 492,387 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/1052725.jf' in 1 s at rate of 492,387 B/s
  Saved file to 'all_readings/1052725.jf'
  Process reports that it wrote 492,387 bytes. OK.
  (Printed and reset $echo)
At 33 seconds(key=13)
array key 13 skipped. (Looking for group 0. 13 mod 4 = 1)

At 33 seconds(key=14)
array key 14 skipped. (Looking for group 0. 14 mod 4 = 2)

At 33 seconds(key=15)
array key 15 skipped. (Looking for group 0. 15 mod 4 = 3)

At 33 seconds(key=16)
  Starting to fetch data
  Fetched 1,078,540 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/807566.jf' in 1 s at rate of 1,078,540 B/s
  Saved file to 'all_readings/807566.jf'
  Process reports that it wrote 1,078,540 bytes. OK.
  (Printed and reset $echo)
At 33 seconds(key=17)
array key 17 skipped. (Looking for group 0. 17 mod 4 = 1)

At 33 seconds(key=18)
array key 18 skipped. (Looking for group 0. 18 mod 4 = 2)

At 33 seconds(key=19)
array key 19 skipped. (Looking for group 0. 19 mod 4 = 3)

At 33 seconds(key=20)
  Starting to fetch data
  Fetched 733,950 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/840299.jf' in 1 s at rate of 733,950 B/s
  Saved file to 'all_readings/840299.jf'
  Process reports that it wrote 733,950 bytes. OK.
  (Printed and reset $echo)
At 34 seconds(key=21)
array key 21 skipped. (Looking for group 0. 21 mod 4 = 1)

At 34 seconds(key=22)
array key 22 skipped. (Looking for group 0. 22 mod 4 = 2)

At 34 seconds(key=23)
array key 23 skipped. (Looking for group 0. 23 mod 4 = 3)

At 34 seconds(key=24)
  Starting to fetch data
  Fetched 4,712,634 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/844534.jf' in 1 s at rate of 4,712,634 B/s
  Saved file to 'all_readings/844534.jf'
  Process reports that it wrote 4,712,634 bytes. OK.
  (Printed and reset $echo)
At 35 seconds(key=25)
array key 25 skipped. (Looking for group 0. 25 mod 4 = 1)

At 35 seconds(key=26)
array key 26 skipped. (Looking for group 0. 26 mod 4 = 2)

At 35 seconds(key=27)
array key 27 skipped. (Looking for group 0. 27 mod 4 = 3)

At 35 seconds(key=28)
  Starting to fetch data
  Fetched 117,570 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/859669.jf' in 1 s at rate of 117,570 B/s
  Saved file to 'all_readings/859669.jf'
  Process reports that it wrote 117,570 bytes. OK.
  (Printed and reset $echo)
At 35 seconds(key=29)
array key 29 skipped. (Looking for group 0. 29 mod 4 = 1)

At 35 seconds(key=30)
array key 30 skipped. (Looking for group 0. 30 mod 4 = 2)

At 35 seconds(key=31)
array key 31 skipped. (Looking for group 0. 31 mod 4 = 3)

At 35 seconds(key=32)
  Starting to fetch data
  Fetched 453,427 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/879721.jf' in 1 s at rate of 453,427 B/s
  Saved file to 'all_readings/879721.jf'
  Process reports that it wrote 453,427 bytes. OK.
  (Printed and reset $echo)
At 35 seconds(key=33)
array key 33 skipped. (Looking for group 0. 33 mod 4 = 1)

At 35 seconds(key=34)
array key 34 skipped. (Looking for group 0. 34 mod 4 = 2)

At 35 seconds(key=35)
array key 35 skipped. (Looking for group 0. 35 mod 4 = 3)

At 35 seconds(key=36)
  Starting to fetch data
  Fetched 177,929 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/887883.jf' in 1 s at rate of 177,929 B/s
  Saved file to 'all_readings/887883.jf'
  Process reports that it wrote 177,929 bytes. OK.
  (Printed and reset $echo)
At 36 seconds(key=37)
array key 37 skipped. (Looking for group 0. 37 mod 4 = 1)

At 36 seconds(key=38)
array key 38 skipped. (Looking for group 0. 38 mod 4 = 2)

At 36 seconds(key=39)
array key 39 skipped. (Looking for group 0. 39 mod 4 = 3)

At 36 seconds(key=40)
  Starting to fetch data
  Fetched 3,686,592 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/903422.jf' in 1 s at rate of 3,686,592 B/s
  Saved file to 'all_readings/903422.jf'
  Process reports that it wrote 3,686,592 bytes. OK.
  (Printed and reset $echo)
At 36 seconds(key=41)
array key 41 skipped. (Looking for group 0. 41 mod 4 = 1)

At 36 seconds(key=42)
array key 42 skipped. (Looking for group 0. 42 mod 4 = 2)

At 36 seconds(key=43)
array key 43 skipped. (Looking for group 0. 43 mod 4 = 3)

At 36 seconds(key=44)
  Starting to fetch data
  Fetched 573,299 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/929116.jf' in 1 s at rate of 573,299 B/s
  Saved file to 'all_readings/929116.jf'
  Process reports that it wrote 573,299 bytes. OK.
  (Printed and reset $echo)
At 37 seconds(key=45)
array key 45 skipped. (Looking for group 0. 45 mod 4 = 1)

At 37 seconds(key=46)
array key 46 skipped. (Looking for group 0. 46 mod 4 = 2)

At 37 seconds(key=47)
array key 47 skipped. (Looking for group 0. 47 mod 4 = 3)

At 37 seconds(key=48)
  Starting to fetch data
  Fetched 1,480,160 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/940875.jf' in 1 s at rate of 1,480,160 B/s
  Saved file to 'all_readings/940875.jf'
  Process reports that it wrote 1,480,160 bytes. OK.
  (Printed and reset $echo)
At 38 seconds(key=49)
array key 49 skipped. (Looking for group 0. 49 mod 4 = 1)

At 38 seconds(key=50)
array key 50 skipped. (Looking for group 0. 50 mod 4 = 2)

At 38 seconds(key=51)
array key 51 skipped. (Looking for group 0. 51 mod 4 = 3)

At 38 seconds(key=52)
  Starting to fetch data
  Fetched 92,566 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/954903.jf' in 1 s at rate of 92,566 B/s
  Saved file to 'all_readings/954903.jf'
  Process reports that it wrote 92,566 bytes. OK.
  (Printed and reset $echo)
A total of 69,489,507 file bytes were written in 38 seconds.

At 38 seconds(key=53) array key 53 skipped. (Looking for group 0. 53 mod 4 = 1) At 38 seconds(key=54) array key 54 skipped. (Looking for group 0. 54 mod 4 = 2)

FINISHED