• A46 prealpha ./mis poll forced consuming 100% CPU

    From Zip@21:1/202 to g00r00 on Sun Mar 15 13:13:14 2020
    Hello g00r00!

    Just noticed that my A46 prealpha MIS poll subprocess ('./mis poll forced') is consuming almost 100% CPU since 00:28 this morning:

    bbs 11329 0.0 0.0 647572 5468 ? SLsl mar14 0:33 /home/bbs/mystic/mis root /home/bbs/mystic daemon
    bbs 26825 0.0 0.0 2388 756 ? S 00:28 0:00 /bin/sh -c ./mis poll forced 1> /dev/null 2> /dev/null
    bbs 26826 99.9 0.0 225636 5620 ? RLl 00:28 755:39 ./mis poll forced

    From 'top':

    PID USER PR NI VIRT RES SHR S %CPU %MEM TIME+ COMMAND 26826 bbs 20 0 225636 5620 4528 R 93,3 0,1 757:52.23 mis

    It is constantly doing this:

    bbs@glimmer:~$ strace -f -vvv -s65535 -p 26826 2>&1

    /../

    [pid 26826] clock_gettime(CLOCK_MONOTONIC, {tv_sec=3034047,
    tv_nsec=429325184}) = 0
    [pid 26826] select(1, [0], NULL, NULL, {tv_sec=0, tv_usec=250000}) = 1 (in
    [0], left {tv_sec=0, tv_usec=249999})
    [pid 26826] select(1, [0], NULL, NULL, {tv_sec=0, tv_usec=0}) = 1 (in [0],
    left {tv_sec=0, tv_usec=0})
    [pid 26826] read(0, "", 256) = 0
    [pid 26826] select(1, [0], NULL, NULL, {tv_sec=0, tv_usec=0}) = 1 (in [0],
    left {tv_sec=0, tv_usec=0})
    [pid 26826] read(0, "", 256) = 0
    [pid 26826] clock_gettime(CLOCK_MONOTONIC, {tv_sec=3034047,
    tv_nsec=429457506}) = 0
    [pid 26826] select(1, [0], NULL, NULL, {tv_sec=0, tv_usec=250000}) = 1 (in
    [0], left {tv_sec=0, tv_usec=249999})
    [pid 26826] select(1, [0], NULL, NULL, {tv_sec=0, tv_usec=0}) = 1 (in [0],
    left {tv_sec=0, tv_usec=0})
    [pid 26826] read(0, "", 256) = 0
    [pid 26826] select(1, [0], NULL, NULL, {tv_sec=0, tv_usec=0}) = 1 (in [0],
    left {tv_sec=0, tv_usec=0})
    [pid 26826] read(0, "", 256) = 0

    bbs@glimmer:~$ ps uaxwww |grep mis
    bbs 5123 0.0 0.0 8932 820 pts/0 S+ 13:03 0:00 grep mis
    bbs 11329 0.0 0.0 647572 5468 ? SLsl mar14 0:33 /home/bbs/mystic/mis root /home/bbs/mystic daemon
    bbs 26825 0.0 0.0 2388 756 ? S 00:28 0:00 /bin/sh -c ./mis poll forced 1> /dev/null 2> /dev/null
    bbs 26826 99.9 0.0 225636 5620 ? RLl 00:28 755:39 ./mis poll forced

    When I check poll.log, it appears that it succeeded polling:

    --------------------- POLL v1.12 A46 2020/03/11 Sun, Mar 15 2020 (loglevel 2) + 2020.03.15 00:28:04 Polling all nodes of session type ALL
    + 2020.03.15 00:28:04 1-Polling 21:1/100 on slot 1 via BINKP
    + 2020.03.15 00:28:04 1-Connecting to agency.bbs.nz on port 24553
    + 2020.03.15 00:28:07 1-Connected by IPV4 SSL to 219.89.83.33
    + 2020.03.15 00:28:08 1-System fsxHUB Risa [NET1]
    + 2020.03.15 00:28:08 1-SysOp Avon
    + 2020.03.15 00:28:08 1-Info TIME Sun, 15 Mar 2020 12:27:57 +1300
    + 2020.03.15 00:28:08 1-Mailer Mystic/1.12A46 binkp/1.0
    + 2020.03.15 00:28:08 1-Info BUILD 2020/03/12 04:19:41 Windows/32
    + 2020.03.15 00:28:09 1-Remote Queue: 0 files 0 bytes
    + 2020.03.15 00:28:09 1-Session ended (0 sent, 0 rcvd, 0 skip)
    + 2020.03.15 00:28:10 Polled 1 systems

    Any ideas what could be causing this?
    I had to restart MIS to resolve this.

    Many thanks in advance! =)

    Best regards
    Zip

    --- Mystic BBS v1.12 A46 2020/03/11 (Linux/64)
    * Origin: Star Collision BBS, Uppsala, Sweden (21:1/202)