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

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

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

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

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

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

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

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

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

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

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

At 4 seconds (key=14)
  Starting to fetch data
  Fetched 4,249,023 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/807566.csv' in 2 s at rate of 2,124,512 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 6 seconds (key=15)
Array key 15 skipped. (Time is 02:13. Hour mod 4 is 2, so looking for group 2. But array key 15 mod 4 = group 3)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 24 seconds (key=46)
  Starting to fetch data
  Fetched 4,437,591 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/940875.csv' in 3 s at rate of 1,479,197 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 27 seconds (key=47)
Array key 47 skipped. (Time is 02:13. Hour mod 4 is 2, so looking for group 2. But array key 47 mod 4 = group 3)

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

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

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

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

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

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

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

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

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

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

At 29 seconds(key=10)
  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 29 seconds(key=11)
array key 11 skipped. (Looking for group 2. 11 mod 4 = 3)

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

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

At 29 seconds(key=14)
  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 30 seconds(key=15)
array key 15 skipped. (Looking for group 2. 15 mod 4 = 3)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 38 seconds(key=46)
  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 39 seconds(key=47)
array key 47 skipped. (Looking for group 2. 47 mod 4 = 3)

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

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

At 39 seconds(key=50)
  Starting to fetch data
  Fetched 90,964 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/954903.jf' in 1 s at rate of 90,964 B/s
  Saved file to 'all_readings/954903.jf'
  Process reports that it wrote 90,964 bytes. OK.
  (Printed and reset $echo)
A total of 65,423,462 file bytes were written in 39 seconds.

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

FINISHED