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 17:13:02 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)
Array key 0 skipped. (Time is 17:13. Hour mod 4 is 1, so looking for group 1. But array key 0 mod 4 = group 0)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 5 seconds (key=21)
  Starting to fetch data
  Fetched 18,601,314 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/840300.csv' in 9 s at rate of 2,066,813 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/840300.csv'
  Process reports that it wrote 18,601,314 bytes. OK.
  Extracted new restart as 6425526
  Appended new restart data 6425526 to file 'all_readings/840300.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 14 seconds (key=22)
Array key 22 skipped. (Time is 17:13. Hour mod 4 is 1, so looking for group 1. But array key 22 mod 4 = group 2)

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

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

At 14 seconds (key=25)
  Starting to fetch data
  Fetched 3,117,908 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/844555.csv' in 2 s at rate of 1,558,954 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/844555.csv'
  Process reports that it wrote 3,117,908 bytes. OK.
  Extracted new restart as 936279
  Appended new restart data 936279 to file 'all_readings/844555.restart.txp'
  Process reports that it wrote 7 bytes. OK.
  (Printed and reset $echo)
At 16 seconds (key=26)
Array key 26 skipped. (Time is 17:13. Hour mod 4 is 1, so looking for group 1. But array key 26 mod 4 = group 2)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 28 seconds (key=53)
  Starting to fetch data
  Fetched 5,360,352 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/954904.csv' in 4 s at rate of 1,340,088 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/954904.csv'
  Process reports that it wrote 5,360,352 bytes. OK.
  Extracted new restart as 1328993
  Appended new restart data 1328993 to file 'all_readings/954904.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)

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

Now scanning for *.jf files ...

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 34 seconds(key=21)
  Starting to fetch data
  Fetched 6,000,438 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/840300.jf' in 2 s at rate of 3,000,219 B/s
  Saved file to 'all_readings/840300.jf'
  Process reports that it wrote 6,000,438 bytes. OK.
  (Printed and reset $echo)
At 36 seconds(key=22)
array key 22 skipped. (Looking for group 1. 22 mod 4 = 2)

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

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

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

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

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

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

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

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

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

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

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

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

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

At 40 seconds(key=40)
array key 40 skipped. (Looking for group 1. 40 mod 4 = 0)

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

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

At 40 seconds(key=44)
array key 44 skipped. (Looking for group 1. 44 mod 4 = 0)

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

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

At 41 seconds(key=48)
array key 48 skipped. (Looking for group 1. 48 mod 4 = 0)

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

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

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

At 42 seconds(key=53)
  Starting to fetch data
  Fetched 1,338,037 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/954904.jf' in 1 s at rate of 1,338,037 B/s
  Saved file to 'all_readings/954904.jf'
  Process reports that it wrote 1,338,037 bytes. OK.
  (Printed and reset $echo)
A total of 75,416,234 file bytes were written in 42 seconds.

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

FINISHED