Hercules 3.06 delays during startup

[twrcast]

I upgraded the Windows version of Hercules from 3.03 to 3.06. Now when I start it there are two 90 second to 2 minute delays during the startup. The first happens right at the start and the second after the crypto modules are loaded. After that everything appears to work fine. Below is the log and you can see the from the time stamp where the delays happen.

Any thoughts on why this is happening?

13:29:59.983 ******** Preferred executable files directory = C:/Program Files/hercules/hercules-3.06/
13:29:59.998 Hercules started; process-id=00001574
13:31:30.829 00001574 Hercules Version 3.06
13:31:30.829 00001574 (c)Copyright 1999-2007 by Roger Bowler, Jan Jaeger, and others
13:31:30.829 00001574 Built on Jan 10 2009 at 01:56:22
13:31:30.829 00001574 Build information:
13:31:30.829 00001574   Win32 (MSVC) build
13:31:30.829 00001574   Modes: S/370 ESA/390 z/Arch
13:31:30.829 00001574   Max CPU Engines: 8
13:31:30.829 00001574   Using fthreads instead of pthreads
13:31:30.829 00001574   Dynamic loading support
13:31:30.829 00001574   Loadable module default base directory is .
13:31:30.829 00001574   Using shared libraries
13:31:30.829 00001574   HTTP Server support
13:31:30.830 00001574   No SIGABEND handler
13:31:30.830 00001574   Regular Expressions support
13:31:30.830 00001574   Automatic Operator support
13:31:30.830 00001574   Machine dependent assists: cmpxchg1 cmpxchg4 cmpxchg8 fetch_dw store_dw
13:31:30.830 00001574 Running on SINGER-LATE6500 Windows_NT-6.0 i686 MP=2
13:31:30.837 00001574 Crypto module loaded (c) Copyright Bernard van der Helm, 2003-2008
13:31:30.837 00001574   Active: Message Security Assist
13:31:30.837 00001574           Message Security Assist Extension 1
13:31:30.837 00001574           Message Security Assist Extension 2
13:33:32.343 00001574 HHCCF065I Hercules: tid=0000224C, pid=5492, pgid=5492, priority=0
13:34:32.354 00001574 HHCSD004I Device 000C bound to socket localhost:3505
13:34:32.354 00001574 HHCSD020I Socketdevice listener thread started: tid=00002538, pid=5492
13:34:32.374 00001574 HHCTE001I Console connection thread started: tid=00001FEC, pid=5492
13:34:32.374 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/sort01.131 cyls=200 heads=20 tracks=4000 trklen=7680
13:34:32.375 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/sort02.132 cyls=200 heads=20 tracks=4000 trklen=7680
13:34:32.375 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/sort03.133 cyls=200 heads=20 tracks=4000 trklen=7680
13:34:32.376 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/sort04.134 cyls=200 heads=20 tracks=4000 trklen=7680
13:34:32.376 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/sort05.135 cyls=200 heads=20 tracks=4000 trklen=7680
13:34:32.377 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/sort06.136 cyls=200 heads=20 tracks=4000 trklen=7680
13:34:32.377 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/work00.140 cyls=555 heads=30 tracks=16650 trklen=19456
13:34:32.378 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/mvsres.148 cyls=560 heads=30 tracks=16800 trklen=19456
13:34:32.380 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/smp001.149 cyls=560 heads=30 tracks=16800 trklen=19456
13:34:32.380 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/smp002.14a cyls=560 heads=30 tracks=16800 trklen=19456
13:34:32.381 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/smp003.14b cyls=560 heads=30 tracks=16800 trklen=19456
13:34:32.381 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/smp004.14c cyls=560 heads=30 tracks=16800 trklen=19456
13:34:32.384 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/hasp00.152 cyls=404 heads=19 tracks=7676 trklen=13312
13:34:32.386 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/page00.160 cyls=698 heads=12 tracks=8376 trklen=8704
13:34:32.389 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/page01.161 cyls=698 heads=12 tracks=8376 trklen=8704
13:34:32.392 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/work01.170 cyls=959 heads=12 tracks=11508 trklen=35840
13:34:32.392 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/work02.180 cyls=885 heads=15 tracks=13275 trklen=47616
13:34:32.393 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/work03.190 cyls=1113 heads=15 tracks=16695 trklen=56832
13:34:32.394 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/mvscat.191 cyls=1113 heads=15 tracks=16695 trklen=56832
13:34:32.395 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/pub000.240 cyls=555 heads=30 tracks=16650 trklen=19456
13:34:32.396 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/mvsdlb.248 cyls=560 heads=30 tracks=16800 trklen=19456
13:34:32.400 00001574 HHCDA020I c:/PROGRA~1/mvs38j/dasd/pub002.280 cyls=1770 heads=15 tracks=26550 trklen=47616
13:34:32.408 00001574 HHCCF069I Run-options enabled for this run:
13:34:32.408 00001574           NUMCPU:           1
13:34:32.408 00001574           ASN-and-LX-reuse: DISabled
13:34:32.408 00001574           DIAG8CMD:         DISabled
13:34:32.408 00001574 HHCCP002I CPU0000 thread started: tid=00001C54, pid=5492, priority=15
13:34:32.408 00001574 HHCCP003I CPU0000 architecture mode S/370
13:34:32.408 00001574 HHCTT002I Timer thread started: tid=0000151C, pid=5492, priority=-20
13:34:32.408 00001574 HHCDG001I dyngui.dll initiated
13:34:32.410 00001574 HHCPN008I Script file processing started using file "hercules.rc"
13:34:32.410 00001574 devlist
13:34:32.410 00001574 0:0009 3215
13:34:32.411 00001574 0:000C 3505 localhost:3505 sockdev ascii trunc eof
13:34:32.411 00001574      (no one currently connected)
13:34:32.411 00001574 0:000D 3525 c:/PROGRA~1/mvs38j/pch/pch00d.txt ascii
13:34:32.411 00001574 0:000E 1403 c:/PROGRA~1/mvs38j/prt/prt00e.txt crlf
13:34:32.411 00001574 0:000F 1403 c:/PROGRA~1/mvs38j/prt/prt00f.txt
13:34:32.413 00001574 0:0010 3270
13:34:32.414 00001574 0:00C0 3270
13:34:32.414 00001574 0:00C1 3270
13:34:32.414 00001574 0:010C 3505 c:/PROGRA~1/mvs38j/jcl/dummy eof
13:34:32.414 00001574 0:0131 2314 c:/PROGRA~1/mvs38j/dasd/sort01.131 [200 cyls] open
13:34:32.414 00001574 0:0132 2314 c:/PROGRA~1/mvs38j/dasd/sort02.132 [200 cyls] open
13:34:32.414 00001574 0:0133 2314 c:/PROGRA~1/mvs38j/dasd/sort03.133 [200 cyls] open
13:34:32.414 00001574 0:0134 2314 c:/PROGRA~1/mvs38j/dasd/sort04.134 [200 cyls] open
13:34:32.414 00001574 0:0135 2314 c:/PROGRA~1/mvs38j/dasd/sort05.135 [200 cyls] open
13:34:32.414 00001574 0:0136 2314 c:/PROGRA~1/mvs38j/dasd/sort06.136 [200 cyls] open
13:34:32.414 00001574 0:0140 3350 c:/PROGRA~1/mvs38j/dasd/work00.140 [555 cyls] open
13:34:32.414 00001574 0:0148 3350 c:/PROGRA~1/mvs38j/dasd/mvsres.148 [560 cyls] open
13:34:32.414 00001574 0:0149 3350 c:/PROGRA~1/mvs38j/dasd/smp001.149 [560 cyls] open
13:34:32.414 00001574 0:014A 3350 c:/PROGRA~1/mvs38j/dasd/smp002.14a [560 cyls] open
13:34:32.414 00001574 0:014B 3350 c:/PROGRA~1/mvs38j/dasd/smp003.14b [560 cyls] open
13:34:32.414 00001574 0:014C 3350 c:/PROGRA~1/mvs38j/dasd/smp004.14c [560 cyls] open
13:34:32.414 00001574 0:0152 3330 c:/PROGRA~1/mvs38j/dasd/hasp00.152 [404 cyls] open
13:34:32.414 00001574 0:0160 3340 c:/PROGRA~1/mvs38j/dasd/page00.160 [698 cyls] open
13:34:32.415 00001574 0:0161 3340 c:/PROGRA~1/mvs38j/dasd/page01.161 [698 cyls] open
13:34:32.415 00001574 0:0170 3375 c:/PROGRA~1/mvs38j/dasd/work01.170 [959 cyls] open
13:34:32.415 00001574 0:0180 3380 c:/PROGRA~1/mvs38j/dasd/work02.180 [885 cyls] open
13:34:32.415 00001574 0:0190 3390 c:/PROGRA~1/mvs38j/dasd/work03.190 [1113 cyls] open
13:34:32.415 00001574 0:0191 3390 c:/PROGRA~1/mvs38j/dasd/mvscat.191 [1113 cyls] open
13:34:32.415 00001574 0:0240 3350 c:/PROGRA~1/mvs38j/dasd/pub000.240 [555 cyls] open
13:34:32.415 00001574 0:0248 3350 c:/PROGRA~1/mvs38j/dasd/mvsdlb.248 [560 cyls] open
13:34:32.415 00001574 0:0280 3380 c:/PROGRA~1/mvs38j/dasd/pub002.280 [1770 cyls] open
13:34:32.415 00001574 0:030E 1403 c:/PROGRA~1/mvs38j/log/hardcopy.log
13:34:32.415 00001574 0:0480 3420 *
13:34:32.415 00001574 panrate 1000
13:34:32.415 00001574 HHCPN037I Panel refresh rate = 1000 millisecond(s)
13:34:32.415 00001574 HHCPN013I EOF reached on SCRIPT file. Processing complete.
13:34:32.415 00001574 HHCAO001I Hercules Automatic Operator thread started;
13:34:32.415 00001574           tid=00001584, pri=0, pid=5492
13:35:02.373 00001574 HHCTE003I Waiting for console connection on port 3270
13:35:12.599 sh startterm2
13:35:12.612 Command started; process-id=00002318
13:35:12.870 00001574 HHCTE009I Client 127.0.0.1 connected to 3270 device 0:0010
13:35:12.950 00001574 HHCTE009I Client 127.0.0.1 connected to 3215 device 0:0009
13:35:13.065 00001574 HHCTE009I Client 127.0.0.1 connected to 3270 device 0:00C0
13:35:13.150 00001574 HHCTE009I Client 127.0.0.1 connected to 3270 device 0:00C1
13:35:25.385 00001574 ipl 0148
13:35:25.499 00001574 CPU0000: SIGP Initial program reset (07) CPU0001, PARM 00000000: CC 3
13:35:25.499 00001574 CPU0000: SIGP Initial program reset (07) CPU0002, PARM 00000000: CC 3
13:35:25.499 00001574 CPU0000: SIGP Initial program reset (07) CPU0003, PARM 00000000: CC 3
13:35:25.500 00001574 CPU0000: SIGP Initial program reset (07) CPU0004, PARM 00000000: CC 3
13:35:25.500 00001574 CPU0000: SIGP Initial program reset (07) CPU0005, PARM 00000000: CC 3
13:35:25.500 00001574 CPU0000: SIGP Initial program reset (07) CPU0006, PARM 00000000: CC 3
13:35:25.500 00001574 CPU0000: SIGP Initial program reset (07) CPU0007, PARM 00000000: CC 3
13:35:38.312 00001574 HHCCD001I Readahead thread 1 started: tid=00002710, pid=5492
13:35:38.312 00001574 HHCCD001I Readahead thread 2 started: tid=000025F0, pid=5492
13:35:38.350 00001574 HHCCD002I Writer thread 1 started: tid=000024F0, pid=5492
13:35:38.354 00001574 HHCCD003I Garbage collector thread started: tid=00001E40, pid=5492
13:35:39.340 00001574 HHCCD002I Writer thread 2 started: tid=00001510, pid=5492
14:02:13.432 00001574 HHCCP011I CPU0000: Disabled wait state
14:02:13.432 00001574           PSW=000A0000 00000CCC
14:02:17.615 00001574 HHCTE014I 3270 device 0010 client 127.0.0.1 connection reset
14:02:18.951 00001574 HHCTE014I 3270 device 00C0 client 127.0.0.1 connection reset
14:02:25.367 00001574 HHCTE014I 3270 device 00C1 client 127.0.0.1 connection reset
14:02:42.250 00001574 HHCTE008I Device 0009 connection closed by client 127.0.0.1
14:02:42.257 Command ended; rc=0
14:02:51.530 00001574 exit
14:02:51.530 00001574 HHCIN900I Begin Hercules shutdown
14:02:51.530 00001574 HHCIN901I Releasing configuration
14:02:51.530 00001574 HHCCP008I CPU0000 thread ended: tid=00001C54, pid=5492
14:02:51.530 00001574 HHCCF047I Subchannel 0:0000 detached
14:02:51.530 00001574 HHCCF047I Subchannel 0:0001 detached
14:02:51.530 00001574 HHCCF047I Subchannel 0:0002 detached
14:02:51.531 00001574 HHCCF047I Subchannel 0:0003 detached
14:02:51.531 00001574 HHCCF047I Subchannel 0:0004 detached
14:02:51.531 00001574 HHCTT003I Timer thread ended
14:02:51.531 00001574 HHCAO002I Hercules Automatic Operator thread ended
14:02:51.532 00001574 HHCCF047I Subchannel 0:0005 detached
14:02:51.532 00001574 HHCCF047I Subchannel 0:0006 detached
14:02:51.533 00001574 HHCCF047I Subchannel 0:0007 detached
14:02:51.533 00001574 HHCCF047I Subchannel 0:0008 detached
14:02:51.533 00001574 HHCCF047I Subchannel 0:0009 detached
14:02:51.533 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.533 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.533 00001574 HHCCD213I [*]      34336   0%    1          1       0       1       0        1
14:02:51.533 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/sort01.131
14:02:51.535 00001574 HHCCD216I [0]      34336   0%    1 rw       1       0       1
14:02:51.536 00001574 HHCCF047I Subchannel 0:000A detached
14:02:51.536 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.536 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.536 00001574 HHCCD213I [*]      34336   0%    1          1       0       1       0        1
14:02:51.537 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/sort02.132
14:02:51.537 00001574 HHCCD216I [0]      34336   0%    1 rw       1       0       1
14:02:51.537 00001574 HHCCF047I Subchannel 0:000B detached
14:02:51.537 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.537 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.537 00001574 HHCCD213I [*]      34336   0%    1          1       0       1       0        1
14:02:51.537 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/sort03.133
14:02:51.537 00001574 HHCCD216I [0]      34336   0%    1 rw       1       0       1
14:02:51.538 00001574 HHCCF047I Subchannel 0:000C detached
14:02:51.538 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.538 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.538 00001574 HHCCD213I [*]      34336   0%    1          1       0       1       0        1
14:02:51.538 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/sort04.134
14:02:51.538 00001574 HHCCD216I [0]      34336   0%    1 rw       1       0       1
14:02:51.540 00001574 HHCCF047I Subchannel 0:000D detached
14:02:51.540 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.540 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.540 00001574 HHCCD213I [*]      34336   0%    1          1       0       1       0        1
14:02:51.540 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/sort05.135
14:02:51.544 00001574 HHCCD216I [0]      34336   0%    1 rw       1       0       1
14:02:51.544 00001574 HHCCF047I Subchannel 0:000E detached
14:02:51.544 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.544 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.545 00001574 HHCCD213I [*]      34336   0%    1          1       0       1       0        1
14:02:51.545 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/sort06.136
14:02:51.545 00001574 HHCCD216I [0]      34336   0%    1 rw       1       0       1
14:02:51.546 00001574 HHCCF047I Subchannel 0:000F detached
14:02:51.546 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.546 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.546 00001574 HHCCD213I [*]    4168174   0%    0          3      91       3       0        3
14:02:51.546 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/work00.140
14:02:51.546 00001574 HHCCD216I [0]    4168174   0%    0 rw       3      91       3
14:02:51.548 00001574 HHCTE004I Console connection thread terminated
14:02:51.548 00001574 HHCCF047I Subchannel 0:0010 detached
14:02:51.548 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.548 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.548 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.548 00001574 HHCCD213I [*]   16552573   1%    4        425    6248      32     990     1291
14:02:51.548 00001574 HHCCD214I                                                         136       31
14:02:51.548 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/mvsres.148
14:02:51.548 00001574 HHCCD216I [0]   16552573   1%    4 rw     425    6248      32
14:02:51.549 00001574 HHCCF047I Subchannel 0:0011 detached
14:02:51.550 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.550 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.550 00001574 HHCCD213I [*]    4943826   0%    0          2     110       5       0        2
14:02:51.550 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/smp001.149
14:02:51.550 00001574 HHCCD216I [0]    4943826   0%    0 rw       2     110       5
14:02:51.551 00001574 HHCCF047I Subchannel 0:0012 detached
14:02:51.551 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.551 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.552 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.552 00001574 HHCCD213I [*]    1088316   0%    0          3      12       1       0        3
14:02:51.552 00001574 HHCCD214I                                                           0        1
14:02:51.552 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/smp002.14a
14:02:51.552 00001574 HHCCD216I [0]    1088316   0%    0 rw       3      12       1
14:02:51.553 00001574 HHCCF047I Subchannel 0:0013 detached
14:02:51.553 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.553 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.554 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.555 00001574 HHCCD213I [*]   14510957   0%    0          5      88       6       3        8
14:02:51.555 00001574 HHCCD214I                                                           0        1
14:02:51.555 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/smp003.14b
14:02:51.555 00001574 HHCCD216I [0]   14510957   0%    0 rw       5      88       6
14:02:51.556 00001574 HHCCF047I Subchannel 0:0014 detached
14:02:51.556 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.556 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.556 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.556 00001574 HHCCD213I [*]   20037664   0%    0          8    1815      13       6       12
14:02:51.556 00001574 HHCCD214I                                                           4        1
14:02:51.556 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/smp004.14c
14:02:51.556 00001574 HHCCD216I [0]   20037664   0%    0 rw       8    1815      13
14:02:51.559 00001574 HHCCF047I Subchannel 0:0015 detached
14:02:51.559 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.560 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.560 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.560 00001574 HHCCD213I [*]     797135   0%    0        436   87076      24     540      880
14:02:51.560 00001574 HHCCD214I                                                          96       27
14:02:51.560 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/hasp00.152
14:02:51.560 00001574 HHCCD216I [0]     797135   0%    0 rw     436   87076      24
14:02:51.561 00001574 HHCCF047I Subchannel 0:0016 detached
14:02:51.562 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.562 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.562 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.563 00001574 HHCCD213I [*]    7298121  19%    2        739  109998      34     828     1422
14:02:51.563 00001574 HHCCD214I                                                         145       77
14:02:51.563 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/page00.160
14:02:51.563 00001574 HHCCD216I [0]    7298121  19%    2 rw     739  109998      34
14:02:51.565 00001574 HHCCF047I Subchannel 0:0017 detached
14:02:51.565 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.565 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.565 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.566 00001574 HHCCD213I [*]    1290727   0%    0        406  133736      31     786     1006
14:02:51.566 00001574 HHCCD214I                                                         186       56
14:02:51.566 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/page01.161
14:02:51.566 00001574 HHCCD216I [0]    1290727   0%    0 rw     406  133736      31
14:02:51.567 00001574 HHCCF047I Subchannel 0:0018 detached
14:02:51.568 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.568 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.568 00001574 HHCCD213I [*]     327163   0%    0          1       0       1       0        1
14:02:51.568 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/work01.170
14:02:51.568 00001574 HHCCD216I [0]     327163   0%    0 rw       1       0       1
14:02:51.569 00001574 HHCCF047I Subchannel 0:0019 detached
14:02:51.569 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.569 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.569 00001574 HHCCD213I [*]     360904   0%    0          1       0       1       0        1
14:02:51.569 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/work02.180
14:02:51.569 00001574 HHCCD216I [0]     360904   0%    0 rw       1       0       1
14:02:51.571 00001574 HHCCF047I Subchannel 0:001A detached
14:02:51.571 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.571 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.571 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.571 00001574 HHCCD213I [*]     605407   0%    0          5      60       1       7       11
14:02:51.571 00001574 HHCCD214I                                                           2        0
14:02:51.571 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/work03.190
14:02:51.571 00001574 HHCCD216I [0]     605407   0%    0 rw       5      60       1
14:02:51.573 00001574 HHCCF047I Subchannel 0:001B detached
14:02:51.573 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.573 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.573 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.573 00001574 HHCCD213I [*]     520869   0%    0         16      18       3      43       60
14:02:51.573 00001574 HHCCD214I                                                           3        3
14:02:51.573 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/mvscat.191
14:02:51.573 00001574 HHCCD216I [0]     520869   0%    0 rw      16      18       3
14:02:51.574 00001574 HHCCF047I Subchannel 0:001C detached
14:02:51.575 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.575 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.575 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.575 00001574 HHCCD213I [*]    6381445   0%    0        177    5296      14     412      500
14:02:51.575 00001574 HHCCD214I                                                         100       21
14:02:51.575 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/pub000.240
14:02:51.575 00001574 HHCCD216I [0]    6381445   0%    0 rw     177    5296      14
14:02:51.576 00001574 HHCCF047I Subchannel 0:001D detached
14:02:51.577 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.577 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.577 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.577 00001574 HHCCD213I [*]   22550557   4%    2         23   13578      31     583      597
14:02:51.577 00001574 HHCCD214I                                                          23        2
14:02:51.577 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/mvsdlb.248
14:02:51.577 00001574 HHCCD216I [0]   22550557   4%    2 rw      23   13578      31
14:02:51.578 00001574 HHCCF047I Subchannel 0:001E detached
14:02:51.579 00001574 HHCCD210I           size free  nbr st   reads  writes l2reads    hits switches
14:02:51.579 00001574 HHCCD211I                                                  readaheads   misses
14:02:51.579 00001574 HHCCD212I --------------------------------------------------------------------
14:02:51.579 00001574 HHCCD213I [*]     293098   0%    0         37     160     103       5        9
14:02:51.579 00001574 HHCCD214I                                                           2        0
14:02:51.579 00001574 HHCCD215I c:/PROGRA~1/mvs38j/dasd/pub002.280
14:02:51.580 00001574 HHCCD216I [0]     293098   0%    0 rw      37     160     103
14:02:51.580 00001574 HHCCD011I Readahead thread 1 stopping: tid=00002710, pid=5492
14:02:51.580 00001574 HHCCD011I Readahead thread 2 stopping: tid=000025F0, pid=5492
14:02:51.580 00001574 HHCCD013I Garbage collector thread stopping: tid=00001E40, pid=5492
14:02:51.581 00001574 HHCCD012I Writer thread 2 stopping: tid=00001510, pid=5492
14:02:51.581 00001574 HHCCD012I Writer thread 1 stopping: tid=000024F0, pid=5492
14:02:51.581 00001574 HHCCF047I Subchannel 0:001F detached
14:02:51.581 00001574 HHCCF047I Subchannel 0:0020 detached
14:02:51.581 00001574 HHCIN902I Configuration release complete
14:02:51.581 00001574 HHCIN903I Calling termination routines
14:02:51.581 00001574 HHCHD900I Begin shutdown sequence
14:02:51.581 00001574 HHCHD901I Calling console_shutdown
14:02:51.581 00001574 HHCHD902I console_shutdown complete
14:02:51.581 00001574 HHCHD901I Calling term_sockdev
14:02:51.581 00001574 HHCSD022I Socketdevice listener thread terminated
14:02:51.581 00001574 HHCHD902I term_sockdev complete
14:02:51.581 00001574 HHCHD901I Calling hdl_term
14:02:51.581 00001574 HHCHD950I Begin HDL termination sequence
14:02:51.582 00001574 HHCHD951I Calling module dyngui cleanup routine
14:02:51.681 00001574 HHCHD952I Module dyngui cleanup complete
14:02:51.681 00001574 HHCLG014I logger thread terminating
14:02:51.681 00001574 HHCIN099I Hercules terminated
******************** (last line of logfile above) ********************

[fish-8]

-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1

twrcast wrote:

> I upgraded the Windows version of Hercules from 3.03 to 3.06.
> Now when I start it there are two 90 second to 2 minute delays
> during the startup. The first happens right at the start and
> the second after the crypto modules are loaded. After that
> everything appears to work fine. Below is the log and you
> can see the from the time stamp where the delays happen.
>
> Any thoughts on why this is happening?

Off the top of my head, no.  :(

However, I am rather curious whether the problem is with Hercules or with
the version of HercGUI you're using.

Please try the following and report back the results:


1. Try starting Hercules WITHOUT using HercGUI:

   a. Open a command-prompt window and navigate to where
      Hercules is installed:

        cd /d "C:/Program Files/hercules/hercules-3.06"        


   b. Copy your Hercules configuration file to the Hercules
      installation directory:

         copy "x:\path\to\myherc.cfg"


   c. Manually start Hercules without the GUI:

         hercules -f myherc.cfg


If that works (i.e. if it starts okay without the delays you mentioned) then
the problem is the version of HercGUI you're using. Please download a newer
version:

   http://www.softdevlabs.com/hercgui

IMPORTANT NOTE! You will also need to install my "FishLib" too, as my
HercGUI requires it. The download link is about 1/2 down my HercGUI page, in
the "Extras" section. Place it in the same directory as HercGUI for now. (My
new version comes with an installer so this manual installation crap won't
be an issue any more, but UNTIL THEN, you'll still have to do some manual
installing of your own, and that means also installing FishLib along with
the new version of HercGUI.)


2. If you experience the same delays running WITHOUT the GUI, then the
problem is related to Hercules. Try the following:

   a. Download and install the latest version of Microsoft's redistributable
DLLs:

      "Microsoft Visual C++ 2005 Service Pack 1 Redistributable Package ATL
Security Update"
      http://tinyurl.com/nnzjyn

   b. Try starting Hercules with the GUI.
      Does the same delay still occur?

   c. Try starting Hercules WITHOUT the GUI (see #1 above).
      Does the same delay still occur?


3. Try replacing your version of 'conspawn.exe' with the version that is now
distributed with Hercules. (This one is admittedly a long shot!)


Thanks.

- --
"Fish" (David B. Trout) - fish@...
Fight Spam! Join CAUCE! <http://www.cauce.org/>
7 reasons why HTML email is a bad thing
http://www.georgedillon.com/web/html_email_is_evil.shtml
PGP key fingerprints:
DH/DSS: 9F9B BAB0 BA7F C458 1A89 FE26 48F5 D7F4 C4EE 3E2A
RSA: 6B37 7110 7201 9917 9B0D 99E3 55DB 5D58 FADE 4A52





-----BEGIN PGP SIGNATURE-----
Version: PGP Desktop 9.8.0 (Build 2158)
Charset: us-ascii

wj8DBQFK4HdhSPXX9MTuPioRAp4kAJsEr4lURfHUaxQRb4q2+dcv/CSNKgCgrhKQ
j3HpKwx0QEW9WxvQfE5WomI=
=BvmB
-----END PGP SIGNATURE-----

[twrcast]

Thanks for the help. The problem happened with or without the GUI and was fixed by updating the redistributable DLL's and then rebooting.

Thanks again.

--- In hercules-390@..., "Fish" <fish@...> wrote:

>
> -----BEGIN PGP SIGNED MESSAGE-----
> Hash: SHA1
>
> twrcast wrote:
>
> > I upgraded the Windows version of Hercules from 3.03 to 3.06.
> > Now when I start it there are two 90 second to 2 minute delays
> > during the startup. The first happens right at the start and
> > the second after the crypto modules are loaded. After that
> > everything appears to work fine. Below is the log and you
> > can see the from the time stamp where the delays happen.
> >
> > Any thoughts on why this is happening?
>
> Off the top of my head, no.  :(
>
> However, I am rather curious whether the problem is with Hercules or with
> the version of HercGUI you're using.
>
> Please try the following and report back the results:
>
>
> 1. Try starting Hercules WITHOUT using HercGUI:
>
>    a. Open a command-prompt window and navigate to where
>       Hercules is installed:
>
>         cd /d "C:/Program Files/hercules/hercules-3.06"        
>
>
>    b. Copy your Hercules configuration file to the Hercules
>       installation directory:
>
>          copy "x:\path\to\myherc.cfg"
>
>
>    c. Manually start Hercules without the GUI:
>
>          hercules -f myherc.cfg
>
>
> If that works (i.e. if it starts okay without the delays you mentioned) then
> the problem is the version of HercGUI you're using. Please download a newer
> version:
>
>    http://www.softdevlabs.com/hercgui
>
> IMPORTANT NOTE! You will also need to install my "FishLib" too, as my
> HercGUI requires it. The download link is about 1/2 down my HercGUI page, in
> the "Extras" section. Place it in the same directory as HercGUI for now. (My
> new version comes with an installer so this manual installation crap won't
> be an issue any more, but UNTIL THEN, you'll still have to do some manual
> installing of your own, and that means also installing FishLib along with
> the new version of HercGUI.)
>
>
> 2. If you experience the same delays running WITHOUT the GUI, then the
> problem is related to Hercules. Try the following:
>
>    a. Download and install the latest version of Microsoft's redistributable
> DLLs:
>
>       "Microsoft Visual C++ 2005 Service Pack 1 Redistributable Package ATL
> Security Update"
>       http://tinyurl.com/nnzjyn
>
>    b. Try starting Hercules with the GUI.
>       Does the same delay still occur?
>
>    c. Try starting Hercules WITHOUT the GUI (see #1 above).
>       Does the same delay still occur?
>
>
> 3. Try replacing your version of 'conspawn.exe' with the version that is now
> distributed with Hercules. (This one is admittedly a long shot!)
>
>
> Thanks.
>
> - --
> "Fish" (David B. Trout) - fish@...
> Fight Spam! Join CAUCE! <http://www.cauce.org/>
> 7 reasons why HTML email is a bad thing
> http://www.georgedillon.com/web/html_email_is_evil.shtml
> PGP key fingerprints:
> DH/DSS: 9F9B BAB0 BA7F C458 1A89 FE26 48F5 D7F4 C4EE 3E2A
> RSA: 6B37 7110 7201 9917 9B0D 99E3 55DB 5D58 FADE 4A52
>
>
>
>
>
> -----BEGIN PGP SIGNATURE-----
> Version: PGP Desktop 9.8.0 (Build 2158)
> Charset: us-ascii
>
> wj8DBQFK4HdhSPXX9MTuPioRAp4kAJsEr4lURfHUaxQRb4q2+dcv/CSNKgCgrhKQ
> j3HpKwx0QEW9WxvQfE5WomI=
> =BvmB
> -----END PGP SIGNATURE-----
>

[fish-8]

-----BEGIN PGP SIGNED MESSAGE-----
Hash: SHA1

twrcast wrote:
> Fish wrote:
> > twrcast wrote:
> >
> > > I upgraded the Windows version of Hercules from 3.03
> > > to 3.06. Now when I start it there are two 90 second
> > > to 2 minute delays during the startup. [...]
[...]
> > > Any thoughts on why this is happening?
> >
> >
> > Off the top of my head, no.  :(
> >
> > However, I am rather curious whether the problem is with
> > Hercules or with the version of HercGUI you're using.
[...]

> > 2. If you experience the same delays running WITHOUT the GUI,
> > then the problem is related to Hercules. Try the following:
> >
> >    a. Download and install the latest version of Microsoft's
> >       redistributable DLLs:
> >
> >       "Microsoft Visual C++ 2005 Service Pack 1 Redistributable
> >        Package ATL Security Update"
> >        http://tinyurl.com/nnzjyn
>
>
> Thanks for the help. The problem happened with or without the GUI
> and was fixed by updating the redistributable DLL's and then rebooting.
>
> Thanks again.

Excellent! I'm very glad to hear that .. er, "twrcast".  :)

Thank you for letting us know.

I and the rest of the Hercules community do appreciate it.

- --
"Fish" (David B. Trout) - fish@...
Fight Spam! Join CAUCE! <http://www.cauce.org/>
7 reasons why HTML email is a bad thing
http://www.georgedillon.com/web/html_email_is_evil.shtml
PGP key fingerprints:
DH/DSS: 9F9B BAB0 BA7F C458 1A89 FE26 48F5 D7F4 C4EE 3E2A
RSA: 6B37 7110 7201 9917 9B0D 99E3 55DB 5D58 FADE 4A52





-----BEGIN PGP SIGNATURE-----
Version: PGP Desktop 9.8.0 (Build 2158)
Charset: us-ascii

wj8DBQFK4qjBSPXX9MTuPioRAiXoAKDBWekP4o+5WLP6r+vcu/ZTbiWoQgCdH6xy
Benxqzo084IsHxuDoRYxfLo=
=aiM/
-----END PGP SIGNATURE-----