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 01:13:01 on 27-Mar-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,203 bytes from http://pooles.bcra.org.uk:3927/Exports/

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

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

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

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

At 1 seconds (key=1)
  Starting to fetch data
  Fetched 2,428 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1004463.csv' in 1 s at rate of 2,428 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1004463.csv'
  Process reports that it wrote 2,428 bytes. OK.
  Extracted new restart as 1182
  Appended new restart data 1182 to file 'all_readings/1004463.restart.txp'
  Process reports that it wrote 5 bytes. OK.
  (Printed and reset $echo)
At 1 seconds (key=2)
Array key 2 skipped. (Time is 01: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 01: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 01: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 5,825,786 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1017222.csv' in 2 s at rate of 2,912,893 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1017222.csv'
  Process reports that it wrote 5,825,786 bytes. OK.
  Extracted new restart as 1913834
  Appended new restart data 1913834 to file 'all_readings/1017222.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 3 seconds (key=6)
Array key 6 skipped. (Time is 01:13. Hour mod 4 is 1, so looking for group 1. But array key 6 mod 4 = group 2)

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

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

At 3 seconds (key=9)
  Starting to fetch data
  Fetched 123,712 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1046676.csv' in 1 s at rate of 123,712 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1046676.csv'
  Process reports that it wrote 123,712 bytes. OK.
  Extracted new restart as 42367
  Appended new restart data 42367 to file 'all_readings/1046676.restart.txp'
  Process reports that it wrote 6 bytes. OK.
  (Printed and reset $echo)
At 4 seconds (key=10)
Array key 10 skipped. (Time is 01: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 01: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 01: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 9,242,562 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/807565.csv' in 4 s at rate of 2,310,641 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/807565.csv'
  Process reports that it wrote 9,242,562 bytes. OK.
  Extracted new restart as 2345008
  Appended new restart data 2345008 to file 'all_readings/807565.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 8 seconds (key=14)
Array key 14 skipped. (Time is 01:13. Hour mod 4 is 1, so looking for group 1. But array key 14 mod 4 = group 2)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 31 seconds (key=49)
  Starting to fetch data
  Fetched 8,026,708 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/951585.csv' in 4 s at rate of 2,006,677 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/951585.csv'
  Process reports that it wrote 8,026,708 bytes. OK.
  Extracted new restart as 3273554
  Appended new restart data 3273554 to file 'all_readings/951585.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 35 seconds(key=0)
array key 0 skipped. (Looking for group 1. 0 mod 4 = 0)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 51 seconds(key=49)
  Starting to fetch data
  Fetched 2,574,663 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/951585.jf' in 4 s at rate of 643,666 B/s
  Saved file to 'all_readings/951585.jf'
  Process reports that it wrote 2,574,663 bytes. OK.
  (Printed and reset $echo)
A total of 76,024,028 file bytes were written in 55 seconds.

At 55 seconds(key=50) array key 50 skipped. (Looking for group 1. 50 mod 4 = 2) At 55 seconds(key=51) array key 51 skipped. (Looking for group 1. 51 mod 4 = 3) At 55 seconds(key=52) array key 52 skipped. (Looking for group 1. 52 mod 4 = 0)

FINISHED