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 07: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 07:13. Hour mod 4 is 3, so looking for group 3. But array key 0 mod 4 = group 0)

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

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

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

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

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

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

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

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

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

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

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

At 4 seconds (key=15)
  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=16)
Array key 16 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 16 mod 4 = group 0)

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

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

At 8 seconds (key=19)
  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=20)
Array key 20 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 20 mod 4 = group 0)

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

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

At 9 seconds (key=23)
  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=24)
Array key 24 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 24 mod 4 = group 0)

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

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

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

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

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

At 18 seconds (key=31)
  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=32)
Array key 32 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 32 mod 4 = group 0)

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

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

At 18 seconds (key=35)
  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=36)
Array key 36 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 36 mod 4 = group 0)

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

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

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

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

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

At 20 seconds (key=43)
  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 24 seconds (key=44)
Array key 44 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 44 mod 4 = group 0)

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

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

At 24 seconds (key=47)
  Starting to fetch data
  Fetched 7,699,078 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/929129.csv' in 3 s at rate of 2,566,359 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/929129.csv'
  Process reports that it wrote 7,699,078 bytes. OK.
  Extracted new restart as 1812279
  Appended new restart data 1812279 to file 'all_readings/929129.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 27 seconds (key=48)
Array key 48 skipped. (Time is 07:13. Hour mod 4 is 3, so looking for group 3. But array key 48 mod 4 = group 0)

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

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

At 27 seconds (key=51)
  Starting to fetch data
  Fetched 9,441,493 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/951585.csv' in 5 s at rate of 1,888,299 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/951585.csv'
  Process reports that it wrote 9,441,493 bytes. OK.
  Extracted new restart as 3712466
  Appended new restart data 3712466 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 32 seconds(key=0)
array key 0 skipped. (Looking for group 3. 0 mod 4 = 0)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 35 seconds(key=19)
  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 35 seconds(key=20)
array key 20 skipped. (Looking for group 3. 20 mod 4 = 0)

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

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

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

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

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

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

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

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

At 40 seconds(key=31)
  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 40 seconds(key=32)
array key 32 skipped. (Looking for group 3. 32 mod 4 = 0)

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

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

At 40 seconds(key=35)
  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 41 seconds(key=36)
array key 36 skipped. (Looking for group 3. 36 mod 4 = 0)

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

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

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

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

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

At 41 seconds(key=43)
  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 42 seconds(key=44)
array key 44 skipped. (Looking for group 3. 44 mod 4 = 0)

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

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

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

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

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

At 43 seconds(key=51)
  Starting to fetch data
  Fetched 3,017,530 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/951585.jf' in 1 s at rate of 3,017,530 B/s
  Saved file to 'all_readings/951585.jf'
  Process reports that it wrote 3,017,530 bytes. OK.
  (Printed and reset $echo)
A total of 81,170,184 file bytes were written in 44 seconds.

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

FINISHED