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:01 on 28-Feb-2026

Software version 2.3. File /home/bcra/public_html/data/freshen.php (last modified 10:31:47 on 16-Jun-2024).
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. (Looking for group 3. 0 mod 4 = 0)

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

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

At 0 seconds (key=3)
  Starting to fetch data
  Fetched 2,853,632 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1008089.csv' in 2 s at rate of 1,426,816 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1008089.csv'
  Process reports that it wrote 2,853,632 bytes. OK.
  Extracted new restart as 1128430
  Appended new restart data 1128430 to file 'all_readings/1008089.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 2 seconds (key=4)
array key 4 skipped. (Looking for group 3. 4 mod 4 = 0)

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

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

At 2 seconds (key=7)
  Starting to fetch data
  Fetched 3,913,213 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/1021454.csv' in 2 s at rate of 1,956,607 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/1021454.csv'
  Process reports that it wrote 3,913,213 bytes. OK.
  Extracted new restart as 1258553
  Appended new restart data 1258553 to file 'all_readings/1021454.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 4 seconds (key=8)
array key 8 skipped. (Looking for group 3. 8 mod 4 = 0)

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

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

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

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

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

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

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

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

At 5 seconds (key=19)
  Starting to fetch data
  Fetched 17,032,716 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/840300.csv' in 8 s at rate of 2,129,090 B/s
Experimental mining for Vbatt_chk. Code not finished.
  Saved file to 'all_readings/840300.csv'
  Process reports that it wrote 17,032,716 bytes. OK.
  Extracted new restart as 5925783
  Appended new restart data 5925783 to file 'all_readings/840300.restart.txp'
  Process reports that it wrote 8 bytes. OK.
  (Printed and reset $echo)
At 13 seconds (key=20)
array key 20 skipped. (Looking for group 3. 20 mod 4 = 0)

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

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

At 13 seconds (key=23)
  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 15 seconds (key=24)
array key 24 skipped. (Looking for group 3. 24 mod 4 = 0)

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

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

At 15 seconds (key=27)
  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 16 seconds (key=28)
array key 28 skipped. (Looking for group 3. 28 mod 4 = 0)

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

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

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

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

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

At 20 seconds (key=35)
  Starting to fetch data
  Fetched 2,397,302 bytes from 'http://pooles.bcra.org.uk:3927/Exports/all_readings/888271.csv' in 2 s at rate of 1,198,651 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 22 seconds (key=36)
array key 36 skipped. (Looking for group 3. 36 mod 4 = 0)

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

At 39 seconds(key=51)
  Starting to fetch data
  Fetched 1,035,887 bytes from 'http://pooles.bcra.org.uk:3927/Data/current/954904.jf' in 1 s at rate of 1,035,887 B/s
  Saved file to 'all_readings/954904.jf'
  Process reports that it wrote 1,035,887 bytes. OK.
  (Printed and reset $echo)
A total of 72,967,681 file bytes were written in 40 seconds.

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

FINISHED