Repeat unref'd interval persists program until next interval

[mhmeadows63]

Bug: Repeat unref'd interval persists program until next interval

After the ref'd timeout fires, the unref'd interval should not persist the program,
... but it does until the next time the unref'd interval fires.

                  (should-exit-here)     (actually-exits-here)
                              |                   |
                              v                   v
(time)-------------------------------------------->
         ^                   ^                   ^
         |                   |                   |
        300(1st interval)    |                   |
                            350(timeout)         |
                                                600(2nd interval)

// This is an issue for long unref'd intervals such as for garbage-collection.

var assert = require('assert');
var unref_interval = 0;

setInterval(function() {
    ++unref_interval;
}, 300).unref();

setTimeout(function() {}, 350);

process.on('exit', function() {
    assert.strictEqual(unref_interval, 1, "Repeat unref'd interval persists program until next interval");
});

[harlentan]

The uv loop should have exited after the setTimeout timeout.
I am taking time to see it. And I will fix it if it really is a bug.

[mhmeadows63]

That will be good as this has been bothering me for some time.

I am developing a service app, but when signalled to shut down, it sometimes takes up 150s to exit.

Using NODE_DEBUG="net timers" exposed an unknown 150s interval that I am guessing is gc() related and which sometimes delays the exit depending on whether the service has been running long enough.

Question - is there a way to audit the uv loop to see concisely what is preventing exit at any given moment?

[harlentan]

I think your problem has nothing to do with gc.

[mhmeadows63]

Gc() was just speculation, as the 150s interval is not mine, at least not directly.

have you been able to repro?

[harlentan]

yes. I can reproduce it.

[mhmeadows63]

Any conclusions on whether this is a bug or a feature?

If a bug, how long might the fix take to arrive is a stable release of Node ?

[sam-github]

@mhmeadows63

Question: what is preventing exit?
Answer: process._getActiveRequests(), process._getActiveHandles()

[mhmeadows63]

Thanks, I'll enjoy exploring those calls.

[harlentan]

This is not a bug. It's just the action of timer of unref.

[mhmeadows63]

I am surprised given your opening view that 'The uv loop should have exited after the setTimeout timeout'

Is there a way to avoid this delayed exit behaviour?

[harlentan]

The callback of setInterval will start next timer for 3000ms in your code, which is not the only item in the uv loop.
Every start of a timer will increase the reference of uv loop.

[mhmeadows63]

I am unable to make sense of the explanation, The actual behaviour seems to be at odds with the specified behaviour; because following the timeout, only the unref'd interval is outstanding, so should not prevent program exit. Sadly, nobody else seems interested in expressing a view so it appears I shall have to live with it.

Thank you for looking into it.

[tjfontaine]

I cannot get this to reproduce, what's your environment? (platform, arch, version)

[mhmeadows63]

environment: v0.10.26 Windows7 x64