Repository navigation
Investigate flaky test-fs-stat-bigint on macos M1 #45612
Description
Activity
- addedfsIssues and PRs related to file-system APIs and the fs module.Issues and PRs related to file-system APIs and the fs module.flaky-testIssues and PRs involving tests that fail intermittently in CI.Issues and PRs involving tests that fail intermittently in CI.
on Nov 24, 2022 - addedmacosIssues and PRs related to the macOS platform.Issues and PRs related to the macOS platform.
on Nov 24, 2022 Is it specific to v19.x?
I cannot reproduce on
main:$ ./tools/test.py parallel/test-fs-stat-bigint --repeat 1000 -j 50 [00:10|% 100|+ 1000|- 0]: DoneThis also happens to me today on macos m1 version 13.0 running the tests on
main.command:
./tools/test.py parallel/test-fs-stat-bigint --repeat 1000 -j 50Node.js v20.0.0-pre Command: out/Release/node /Users/marcoippolito/Documents/projects/forks/node/test/parallel/test-fs-stat-bigint.js === release test-fs-stat-bigint === Path: parallel/test-fs-stat-bigint node:assert:400 throw err; ^ AssertionError [ERR_ASSERTION]: Number version atimeMs = 1669634672268.1, BigInt version atimeMs = 1669634672248n, Allowable delta = 20 at verifyStats (/Users/marcoippolito/Documents/projects/forks/node/test/parallel/test-fs-stat-bigint.js:71:7) at /Users/marcoippolito/Documents/projects/forks/node/test/parallel/test-fs-stat-bigint.js:158:7 at /Users/marcoippolito/Documents/projects/forks/node/test/common/index.js:448:15 at FSReqCallback.oncomplete (node:fs:199:5) { generatedMessage: false, code: 'ERR_ASSERTION', actual: false, expected: true, operator: '==' }it seems that both these assertions fail:
node/test/parallel/test-fs-stat-bigint.js
Lines 70 to 81 in 3bef549
assert( msFromNum - Number(msFromBigInt) <= allowableDelta, `Number version ${key} = ${msFromNum}, ` + `BigInt version ${key} = ${msFromBigInt}n, ` + `Allowable delta = ${allowableDelta}`); assert( msFromNum - Number(msFromBigIntNs) <= allowableDelta, `Number version ${key} = ${msFromNum}, ` + `BigInt version ${nsKey} = ${nsFromBigInt}n` + ` = ${msFromBigIntNs}ms, Allowable delta = ${allowableDelta}`);
the result of this operations fail inconsistently, exceeding theallowableDelta:
msFromNum - Number(msFromBigIntNs) <= allowableDelta
msFromNum - Number(msFromBigInt) <= allowableDelta
49.189697265625 <= 49- added a commit that references this issue
on Dec 20, 2022 I was able to reproduce the error in about 1% of local runs. With the change in #45925 it appeared to become less flaky locally but really difficult to say for sure.
grr, ok. hmm... the only thing I can think of is artificially setting the allowableDelta higher. What I did notice is that it would fail when the delta was either 0 or 1.
@jasnell I tried to increase the allowableDelta and it still fails
I guess this is particularly on M1, since no one complains the CI for this test?
I noticed this on local m1 env as well. The flakiness rate is pretty high, that I can even manually reproduce it by repeatedly running the test (and hence not related to parallel FWIW).
If I do it for 1000 times. it's about 15%.
$ tools/test.py --repeat=1000 test/parallel/test-fs-stat-bigint.js [00:33|% 100|+ 854|- 146]: DoneI reporoduced it today and i guess with the latest version of macos Version 15.0.1 on M1 it passes All
Darwin Kunals-MacBook-Air-M1.local 24.0.0 Darwin Kernel Version 24.0.0: Tue Sep 24 23:36:26 PDT 2024; root:xnu-11215.1.12~1/RELEASE_ARM64_T8103 arm64$ ./tools/test.py parallel/test-fs-stat-bigint --repeat 1000 -j 50 [00:20|% 100|+ 1000|- 0]: Done All tests passed.
$ tools/test.py --repeat=1000 test/parallel/test-fs-stat-bigint.js [00:22|% 100|+ 1000|- 0]: Done All tests passed.Hi there 🙂
I just wanted to chip in mentioning that I also experienced the flakiness on my Mac machine, I've also opened #58043 to address this flakiness (before @RaisinTen made me notice this issue)
I can confirm that on my machine a large enough allowable delta does seem to fix the issue
Hey @RaisinTen 🙂👋
Quick update on this, I've written a small script that reproduces the flakiness for
statSync(+ adjustments to make it more convenient to use withfs_usage):script
const fs = require("node:fs"); const path = require("node:path"); const assert = require("node:assert"); const { setTimeout } = require("node:timers/promises"); fs.rmSync("./tmp", { force: true, recursive: true }); console.log(`\x1b[32m This process' PID is: ${process.pid} (run: sudo fs_usage -w -f pathname ${process.pid} > fs_usage-logs.txt) \x1b[0m`); (async () => { await setTimeout(15_000); // a timeout so that fs_usage can be called fs.mkdirSync("./tmp"); const attempts = 100_000; const exitOnFail = true; for (let i = 0; i < attempts; i++) { const filename = path.resolve( `./tmp/test_${i}` ); console.log(`\x1b[35m file = ${filename} \x1b[0m`); try { fs.writeFileSync(filename, "test"); const startTime = process.hrtime.bigint(); const bigintStats = fs.statSync(filename, { bigint: true }); const numStats = fs.statSync(filename); const endTime = process.hrtime.bigint(); const allowableDelta = Math.ceil(Number(endTime - startTime) / 1e6); const key = "atimeMs"; const msFromBigInt = bigintStats[key]; const msFromNum = numStats[key]; assert( msFromNum - Number(msFromBigInt) <= allowableDelta, `Number version ${key} = ${msFromNum}, ` + `BigInt version ${key} = ${msFromBigInt}n, ` + `Delta = ${msFromNum - Number(msFromBigInt)}n, ` + `Allowable delta = ${allowableDelta}` ); } catch (e) { if (e instanceof assert.AssertionError) { console.error(e); } if (exitOnFail) { throw e; } } } })();
I've run it and saved the output to a
fs_usage-logs.txtfile (using the command the scripts logs), unfortunately this does not seem to yield any useful information, I'm including below the last few logs present in the file (where thetest_16768file is the one that caused the assertion fail while the rest did not)the only noticeable difference is that the two stat calls on
test_16768are further apart then those of other files, and by quickly scanning all the logs that seems to apply to all the other stats too, when they are too much far apart the assertion fails otherwise it succeeds (I guess that the question now is, why they get further apart and if something else is accessing the file during that time)logs
22:11:35.429301 close F=19 0.000020 node.96435 22:11:35.429306 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16765 0.000003 node.96435 22:11:35.429336 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16765 0.000002 node.96435 22:11:35.429340 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16765 0.000002 node.96435 22:11:35.429342 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16765 0.000002 node.96435 22:11:35.429384 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16765 0.000041 node.96435 22:11:35.429515 open F=19 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16766 0.000049 node.96435 22:11:35.429727 close F=19 0.000117 node.96435 22:11:35.429765 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16766 0.000007 node.96435 22:11:35.429789 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16766 0.000004 node.96435 22:11:35.429796 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16766 0.000003 node.96435 22:11:35.429827 lstat64 /Users/dar`io/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16766 0.000002 node.96435 22:11:35.429920 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16766 0.000092 node.96435 22:11:35.430194 open F=19 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16767 0.000065 node.96435 22:11:35.430271 close F=19 0.000037 node.96435 22:11:35.430284 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16767 0.000011 node.96435 22:11:35.430402 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16767 0.000004 node.96435 22:11:35.430470 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16767 0.000052 node.96435 22:11:35.430622 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16767 0.000017 node.96435 22:11:35.430710 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16767 0.000068 node.96435 22:11:35.430787 open F=19 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16768 0.000059 node.96435 22:11:35.430826 close F=19 0.000022 node.96435 22:11:35.430965 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16768 0.000020 node.96435 22:11:35.436284 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_16768 0.000012 node.96435 22:11:35.466207 close F=4 0.000008 node.96435 22:11:35.466212 close F=5 0.000005 node.96435 22:11:35.466253 close F=10 0.000002 node.96437 22:11:35.466258 close F=9 0.000004 node.96437 22:11:35.466261 close F=8 0.000003 node.96437 22:11:35.466885 close F=7 0.000007 node.96435 22:11:35.466890 close F=6 0.000005 node.96435 22:11:35.466929 close F=3 0.000004 node.96435PS: running
fs_usagewith-f filesysyields very similar results2 remaining items
Do you have the start time, end time and atime values for the success and fail cases? That should help in understanding which one of the atime values is going out of the expected start time ... end time window and by how much.
No I didn't have the values, however I re-run the script and got new logs with the times as well 🙂👍
Updated script
const fs = require("node:fs"); const path = require("node:path"); const assert = require("node:assert"); const { setTimeout } = require("node:timers/promises"); fs.rmSync("./tmp", { force: true, recursive: true }); console.error(`\x1b[32m This process' PID is: ${process.pid} (run: sudo fs_usage -w -f pathname ${process.pid} > fs_usage-logs.txt) \x1b[0m`); (async () => { await setTimeout(15_000); // a timeout so that fs_usage can be called fs.mkdirSync("./tmp"); const attempts = 100_000; const exitOnFail = true; for (let i = 0; i < attempts; i++) { const filename = path.resolve( `./tmp/test_${i}` ); console.error(`\x1b[35m processing ${filename} \x1b[0m`); try { fs.writeFileSync(filename, "test"); const startTime = process.hrtime.bigint(); const bigintStats = fs.statSync(filename, { bigint: true }); const numStats = fs.statSync(filename); const endTime = process.hrtime.bigint(); const allowableDelta = Math.ceil(Number(endTime - startTime) / 1e6); const key = "atimeMs"; const msFromBigInt = bigintStats[key]; const msFromNum = numStats[key]; console.log(` file: ${filename} startTime: ${startTime} endTime: ${endTime} allowableDelta: ${allowableDelta} delta: ${msFromNum - Number(msFromBigInt)} bigintStats[${key}]: ${bigintStats[key]} numStats[${key}]: ${numStats[key]} `); assert( msFromNum - Number(msFromBigInt) <= allowableDelta, `Number version ${key} = ${msFromNum}, ` + `BigInt version ${key} = ${msFromBigInt}n, ` + `Delta = ${msFromNum - Number(msFromBigInt)}n, ` + `Allowable delta = ${allowableDelta}` ); fs.rmSync(filename); // remove the file if no flake occurred } catch (e) { if (e instanceof assert.AssertionError) { console.error(e); } if (exitOnFail) { throw e; } } } })();
Last portion of script output
Note: the assertion failed for
test_17635and succeeded for all the other filesfile: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 startTime: 2643000652625 endTime: 2643000662708 allowableDelta: 1 delta: 0.03759765625 bigintStats[atimeMs]: 1745997990702 numStats[atimeMs]: 1745997990702.0376 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 startTime: 2643000815458 endTime: 2643000829000 allowableDelta: 1 delta: 0.205322265625 bigintStats[atimeMs]: 1745997990702 numStats[atimeMs]: 1745997990702.2053 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 startTime: 2643000985416 endTime: 2643000999500 allowableDelta: 1 delta: 0.3759765625 bigintStats[atimeMs]: 1745997990702 numStats[atimeMs]: 1745997990702.376 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 startTime: 2643001161500 endTime: 2643001171750 allowableDelta: 1 delta: 0.5517578125 bigintStats[atimeMs]: 1745997990702 numStats[atimeMs]: 1745997990702.5518 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 startTime: 2643001338416 endTime: 2643001360208 allowableDelta: 1 delta: 0.724609375 bigintStats[atimeMs]: 1745997990702 numStats[atimeMs]: 1745997990702.7246 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 startTime: 2643001548791 endTime: 2643001565291 allowableDelta: 1 delta: 0.91455078125 bigintStats[atimeMs]: 1745997990702 numStats[atimeMs]: 1745997990702.9146 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 startTime: 2643001740708 endTime: 2643001753333 allowableDelta: 1 delta: 0.1318359375 bigintStats[atimeMs]: 1745997990703 numStats[atimeMs]: 1745997990703.1318 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 startTime: 2643001919041 endTime: 2643001928000 allowableDelta: 1 delta: 0.298095703125 bigintStats[atimeMs]: 1745997990703 numStats[atimeMs]: 1745997990703.298 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 startTime: 2643002102041 endTime: 2643002112791 allowableDelta: 1 delta: 0.486572265625 bigintStats[atimeMs]: 1745997990703 numStats[atimeMs]: 1745997990703.4866 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 startTime: 2643002285833 endTime: 2643002295666 allowableDelta: 1 delta: 0.666259765625 bigintStats[atimeMs]: 1745997990703 numStats[atimeMs]: 1745997990703.6663 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 startTime: 2643002468750 endTime: 2643002480958 allowableDelta: 1 delta: 0.85009765625 bigintStats[atimeMs]: 1745997990703 numStats[atimeMs]: 1745997990703.85 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 startTime: 2643002645750 endTime: 2643002656416 allowableDelta: 1 delta: 0.030029296875 bigintStats[atimeMs]: 1745997990704 numStats[atimeMs]: 1745997990704.03 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 startTime: 2643002809875 endTime: 2643002820083 allowableDelta: 1 delta: 0.199462890625 bigintStats[atimeMs]: 1745997990704 numStats[atimeMs]: 1745997990704.1995 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 startTime: 2643003005333 endTime: 2643003014000 allowableDelta: 1 delta: 0.38671875 bigintStats[atimeMs]: 1745997990704 numStats[atimeMs]: 1745997990704.3867 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 startTime: 2643003173333 endTime: 2643003181916 allowableDelta: 1 delta: 0.560302734375 bigintStats[atimeMs]: 1745997990704 numStats[atimeMs]: 1745997990704.5603 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 startTime: 2643003338541 endTime: 2643003348333 allowableDelta: 1 delta: 0.729248046875 bigintStats[atimeMs]: 1745997990704 numStats[atimeMs]: 1745997990704.7292 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 startTime: 2643003517541 endTime: 2643003529000 allowableDelta: 1 delta: 0.902587890625 bigintStats[atimeMs]: 1745997990704 numStats[atimeMs]: 1745997990704.9026 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 startTime: 2643003714125 endTime: 2643003724750 allowableDelta: 1 delta: 0.085693359375 bigintStats[atimeMs]: 1745997990705 numStats[atimeMs]: 1745997990705.0857 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 startTime: 2643003892916 endTime: 2643003903250 allowableDelta: 1 delta: 0.27978515625 bigintStats[atimeMs]: 1745997990705 numStats[atimeMs]: 1745997990705.2798 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 startTime: 2643004068875 endTime: 2643004089416 allowableDelta: 1 delta: 0.455810546875 bigintStats[atimeMs]: 1745997990705 numStats[atimeMs]: 1745997990705.4558 file: /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17635 startTime: 2643006321333 endTime: 2643006361541 allowableDelta: 1 delta: 2.798583984375 bigintStats[atimeMs]: 1745997990705 numStats[atimeMs]: 1745997990707.7986Last portion of `fs_usage` logs
08:26:30.702104 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 0.000057 node.48102 08:26:30.702138 close F=18 0.000016 node.48102 08:26:30.702146 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 0.000007 node.48102 08:26:30.702148 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 0.000002 node.48102 08:26:30.702159 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 0.000003 node.48102 08:26:30.702161 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 0.000002 node.48102 08:26:30.702205 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17615 0.000043 node.48102 08:26:30.702271 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 0.000058 node.48102 08:26:30.702301 close F=18 0.000015 node.48102 08:26:30.702312 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 0.000011 node.48102 08:26:30.702314 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 0.000002 node.48102 08:26:30.702330 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 0.000008 node.48102 08:26:30.702333 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 0.000002 node.48102 08:26:30.702378 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17616 0.000045 node.48102 08:26:30.702439 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 0.000055 node.48102 08:26:30.702471 close F=18 0.000016 node.48102 08:26:30.702482 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 0.000011 node.48102 08:26:30.702485 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 0.000002 node.48102 08:26:30.702500 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 0.000008 node.48102 08:26:30.702503 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 0.000003 node.48102 08:26:30.702553 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17617 0.000051 node.48102 08:26:30.702616 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 0.000054 node.48102 08:26:30.702647 close F=18 0.000015 node.48102 08:26:30.702654 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 0.000007 node.48102 08:26:30.702657 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 0.000002 node.48102 08:26:30.702676 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 0.000012 node.48102 08:26:30.702679 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 0.000003 node.48102 08:26:30.702726 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17618 0.000047 node.48102 08:26:30.702794 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 0.000061 node.48102 08:26:30.702824 close F=18 0.000015 node.48102 08:26:30.702841 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 0.000017 node.48102 08:26:30.702845 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 0.000003 node.48102 08:26:30.702865 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 0.000012 node.48102 08:26:30.702868 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 0.000003 node.48102 08:26:30.702913 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17619 0.000045 node.48102 08:26:30.702982 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 0.000060 node.48102 08:26:30.703033 close F=18 0.000024 node.48102 08:26:30.703047 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 0.000012 node.48102 08:26:30.703050 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 0.000002 node.48102 08:26:30.703070 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 0.000008 node.48102 08:26:30.703073 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 0.000002 node.48102 08:26:30.703129 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17620 0.000056 node.48102 08:26:30.703197 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 0.000056 node.48102 08:26:30.703226 close F=18 0.000014 node.48102 08:26:30.703233 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 0.000006 node.48102 08:26:30.703238 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 0.000005 node.48102 08:26:30.703253 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 0.000007 node.48102 08:26:30.703255 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 0.000002 node.48102 08:26:30.703296 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17621 0.000041 node.48102 08:26:30.703371 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 0.000068 node.48102 08:26:30.703404 close F=18 0.000016 node.48102 08:26:30.703411 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 0.000006 node.48102 08:26:30.703413 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 0.000002 node.48102 08:26:30.703431 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 0.000003 node.48102 08:26:30.703433 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 0.000002 node.48102 08:26:30.703487 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17622 0.000053 node.48102 08:26:30.703556 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 0.000063 node.48102 08:26:30.703587 close F=18 0.000016 node.48102 08:26:30.703595 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 0.000007 node.48102 08:26:30.703598 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 0.000002 node.48102 08:26:30.703614 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 0.000008 node.48102 08:26:30.703616 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 0.000002 node.48102 08:26:30.703667 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17623 0.000050 node.48102 08:26:30.703737 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 0.000064 node.48102 08:26:30.703771 close F=18 0.000016 node.48102 08:26:30.703778 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 0.000007 node.48102 08:26:30.703781 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 0.000002 node.48102 08:26:30.703798 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 0.000008 node.48102 08:26:30.703800 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 0.000002 node.48102 08:26:30.703852 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17624 0.000052 node.48102 08:26:30.703920 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 0.000062 node.48102 08:26:30.703954 close F=18 0.000015 node.48102 08:26:30.703963 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 0.000009 node.48102 08:26:30.703966 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 0.000002 node.48102 08:26:30.703983 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 0.000008 node.48102 08:26:30.703986 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 0.000002 node.48102 08:26:30.704032 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17625 0.000046 node.48102 08:26:30.704100 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 0.000062 node.48102 08:26:30.704131 close F=18 0.000017 node.48102 08:26:30.704139 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 0.000008 node.48102 08:26:30.704142 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 0.000002 node.48102 08:26:30.704151 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 0.000003 node.48102 08:26:30.704154 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 0.000002 node.48102 08:26:30.704202 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17626 0.000048 node.48102 08:26:30.704266 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 0.000057 node.48102 08:26:30.704295 close F=18 0.000015 node.48102 08:26:30.704303 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 0.000007 node.48102 08:26:30.704305 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 0.000002 node.48102 08:26:30.704321 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 0.000007 node.48102 08:26:30.704324 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 0.000002 node.48102 08:26:30.704383 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17627 0.000059 node.48102 08:26:30.704458 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 0.000069 node.48102 08:26:30.704491 close F=18 0.000016 node.48102 08:26:30.704497 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 0.000006 node.48102 08:26:30.704499 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 0.000002 node.48102 08:26:30.704510 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 0.000002 node.48102 08:26:30.704513 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 0.000002 node.48102 08:26:30.704559 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17628 0.000046 node.48102 08:26:30.704629 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 0.000063 node.48102 08:26:30.704659 close F=18 0.000015 node.48102 08:26:30.704665 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 0.000006 node.48102 08:26:30.704667 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 0.000002 node.48102 08:26:30.704678 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 0.000003 node.48102 08:26:30.704680 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 0.000002 node.48102 08:26:30.704731 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17629 0.000051 node.48102 08:26:30.704796 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 0.000059 node.48102 08:26:30.704824 close F=18 0.000013 node.48102 08:26:30.704831 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 0.000007 node.48102 08:26:30.704834 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 0.000002 node.48102 08:26:30.704846 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 0.000005 node.48102 08:26:30.704848 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 0.000002 node.48102 08:26:30.704903 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17630 0.000055 node.48102 08:26:30.704973 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 0.000063 node.48102 08:26:30.705003 close F=18 0.000015 node.48102 08:26:30.705011 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 0.000008 node.48102 08:26:30.705014 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 0.000003 node.48102 08:26:30.705029 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 0.000007 node.48102 08:26:30.705033 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 0.000002 node.48102 08:26:30.705087 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17631 0.000055 node.48102 08:26:30.705168 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 0.000074 node.48102 08:26:30.705199 close F=18 0.000018 node.48102 08:26:30.705206 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 0.000006 node.48102 08:26:30.705210 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 0.000003 node.48102 08:26:30.705226 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 0.000008 node.48102 08:26:30.705229 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 0.000002 node.48102 08:26:30.705278 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17632 0.000049 node.48102 08:26:30.705349 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 0.000065 node.48102 08:26:30.705378 close F=18 0.000015 node.48102 08:26:30.705386 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 0.000007 node.48102 08:26:30.705388 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 0.000002 node.48102 08:26:30.705404 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 0.000009 node.48102 08:26:30.705412 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 0.000008 node.48102 08:26:30.705455 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17633 0.000042 node.48102 08:26:30.705521 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 0.000060 node.48102 08:26:30.705554 close F=18 0.000017 node.48102 08:26:30.705567 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 0.000012 node.48102 08:26:30.705575 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 0.000007 node.48102 08:26:30.705584 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 0.000003 node.48102 08:26:30.705593 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 0.000008 node.48102 08:26:30.705641 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17634 0.000048 node.48102 08:26:30.705711 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17635 0.000064 node.48102 08:26:30.705804 close F=18 0.000078 node.48102 08:26:30.707830 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17635 0.000016 node.48102 08:26:30.707846 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_17635 0.000009 node.48102 08:26:30.711457 close F=4 0.000003 node.48102 08:26:30.711460 close F=5 0.000003 node.48102 08:26:30.711486 close F=10 0.000001 node.48106 08:26:30.711489 close F=9 0.000002 node.48106 08:26:30.711490 close F=8 0.000002 node.48106 08:26:30.711697 close F=7 0.000002 node.48102 08:26:30.711699 close F=6 0.000002 node.48102 08:26:30.711700 close F=3 0.000001 node.48102Now, you can check with dtruss (you would need to temporarily disable SIP for this) too to verify if mknod, utimes or read is being called which might change the atime value.
Sorry I can't do that as I am using my company's mac and can't really disable SIP on it 😓
Since the start time and end times are measured from the process start time and the times on the stat objects are measured from the system time, it is hard to understand how these are relating to one another. It would help if we can see the numbers relative to the same reference like epoch or system time. Let's also log:
- the birthtime, ctime and mtime values which should be exactly the same for both stat objects but should give us more info of the timing of the file events
- hrtimes before and after the writeFileSync calls to understand the time it takes to create the file
This should help us confirm if both the atimes are more than the birthtime and find out a reliable upper limit for the permissible atime differences.
Reacted by Dario PiotrowiczSure, I can log all the various stats and hrtimes before and afer the write 🙂👍
Updated script
const fs = require("node:fs"); const path = require("node:path"); const assert = require("node:assert"); const { setTimeout } = require("node:timers/promises"); fs.rmSync("./tmp", { force: true, recursive: true }); console.error(`\x1b[32m This process' PID is: ${process.pid} (run: sudo fs_usage -w -f pathname ${process.pid} > fs_usage-logs.txt) \x1b[0m`); (async () => { await setTimeout(15_000); // a timeout so that fs_usage can be called fs.mkdirSync("./tmp"); const attempts = 100_000; const exitOnFail = true; for (let i = 0; i < attempts; i++) { const filename = path.resolve( `./tmp/test_${i}` ); console.error(`\x1b[35m processing ${filename} \x1b[0m`); try { const preWriteHrtime = process.hrtime.bigint(); fs.writeFileSync(filename, "test"); const postWriteHrtime = process.hrtime.bigint(); const startTime = process.hrtime.bigint(); const bigintStats = fs.statSync(filename, { bigint: true }); const numStats = fs.statSync(filename); const endTime = process.hrtime.bigint(); const allowableDelta = Math.ceil(Number(endTime - startTime) / 1e6); const key = "atimeMs"; const msFromBigInt = bigintStats[key]; const msFromNum = numStats[key]; console.log('==='.repeat(10)); console.log(filename); console.log({ startTime, endTime, delta: msFromNum - Number(msFromBigInt), allowableDelta, preWriteHrtime, postWriteHrtime, numStats, bigintStats, }); console.log('==='.repeat(10)); console.log('\n'.repeat(2)); assert( msFromNum - Number(msFromBigInt) <= allowableDelta, `Number version ${key} = ${msFromNum}, ` + `BigInt version ${key} = ${msFromBigInt}n, ` + `Delta = ${msFromNum - Number(msFromBigInt)}n, ` + `Allowable delta = ${allowableDelta}` ); fs.rmSync(filename); // remove the file if no flake occurred } catch (e) { if (e instanceof assert.AssertionError) { console.error(e); } if (exitOnFail) { throw e; } } } })();
Last portion of script output
Note: the assertion failed for
test_6368and succeeded for all the other files============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 { startTime: 54411647773375n, endTime: 54411647814583n, delta: 0.012939453125, allowableDelta: 1, preWriteHrtime: 54411647701541n, postWriteHrtime: 54411647773375n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108751, size: 4, blocks: 8, atimeMs: 1746049759461.013, mtimeMs: 1746049759461.0464, ctimeMs: 1746049759461.0464, birthtimeMs: 1746049759461.013, atime: 2025-04-30T21:49:19.461Z, mtime: 2025-04-30T21:49:19.461Z, ctime: 2025-04-30T21:49:19.461Z, birthtime: 2025-04-30T21:49:19.461Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108751n, size: 4n, blocks: 8n, atimeMs: 1746049759461n, mtimeMs: 1746049759461n, ctimeMs: 1746049759461n, birthtimeMs: 1746049759461n, atimeNs: 1746049759461012839n, mtimeNs: 1746049759461046422n, ctimeNs: 1746049759461046422n, birthtimeNs: 1746049759461012839n, atime: 2025-04-30T21:49:19.461Z, mtime: 2025-04-30T21:49:19.461Z, ctime: 2025-04-30T21:49:19.461Z, birthtime: 2025-04-30T21:49:19.461Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 { startTime: 54411649657291n, endTime: 54411649671333n, delta: 0.83056640625, allowableDelta: 1, preWriteHrtime: 54411649451208n, postWriteHrtime: 54411649656375n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108752, size: 4, blocks: 8, atimeMs: 1746049759462.8306, mtimeMs: 1746049759462.8833, ctimeMs: 1746049759462.8833, birthtimeMs: 1746049759462.8306, atime: 2025-04-30T21:49:19.463Z, mtime: 2025-04-30T21:49:19.463Z, ctime: 2025-04-30T21:49:19.463Z, birthtime: 2025-04-30T21:49:19.463Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108752n, size: 4n, blocks: 8n, atimeMs: 1746049759462n, mtimeMs: 1746049759462n, ctimeMs: 1746049759462n, birthtimeMs: 1746049759462n, atimeNs: 1746049759462830637n, mtimeNs: 1746049759462883262n, ctimeNs: 1746049759462883262n, birthtimeNs: 1746049759462830637n, atime: 2025-04-30T21:49:19.462Z, mtime: 2025-04-30T21:49:19.462Z, ctime: 2025-04-30T21:49:19.462Z, birthtime: 2025-04-30T21:49:19.462Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 { startTime: 54411650378750n, endTime: 54411650417041n, delta: 0.496337890625, allowableDelta: 1, preWriteHrtime: 54411650170583n, postWriteHrtime: 54411650377958n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108753, size: 4, blocks: 8, atimeMs: 1746049759463.4963, mtimeMs: 1746049759463.5742, ctimeMs: 1746049759463.5742, birthtimeMs: 1746049759463.4963, atime: 2025-04-30T21:49:19.463Z, mtime: 2025-04-30T21:49:19.464Z, ctime: 2025-04-30T21:49:19.464Z, birthtime: 2025-04-30T21:49:19.463Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108753n, size: 4n, blocks: 8n, atimeMs: 1746049759463n, mtimeMs: 1746049759463n, ctimeMs: 1746049759463n, birthtimeMs: 1746049759463n, atimeNs: 1746049759463496223n, mtimeNs: 1746049759463574140n, ctimeNs: 1746049759463574140n, birthtimeNs: 1746049759463496223n, atime: 2025-04-30T21:49:19.463Z, mtime: 2025-04-30T21:49:19.463Z, ctime: 2025-04-30T21:49:19.463Z, birthtime: 2025-04-30T21:49:19.463Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 { startTime: 54411651237875n, endTime: 54411651251500n, delta: 0.347900390625, allowableDelta: 1, preWriteHrtime: 54411651029375n, postWriteHrtime: 54411651237875n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108754, size: 4, blocks: 8, atimeMs: 1746049759464.348, mtimeMs: 1746049759464.4673, ctimeMs: 1746049759464.4673, birthtimeMs: 1746049759464.348, atime: 2025-04-30T21:49:19.464Z, mtime: 2025-04-30T21:49:19.464Z, ctime: 2025-04-30T21:49:19.464Z, birthtime: 2025-04-30T21:49:19.464Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108754n, size: 4n, blocks: 8n, atimeMs: 1746049759464n, mtimeMs: 1746049759464n, ctimeMs: 1746049759464n, birthtimeMs: 1746049759464n, atimeNs: 1746049759464347810n, mtimeNs: 1746049759464467227n, ctimeNs: 1746049759464467227n, birthtimeNs: 1746049759464347810n, atime: 2025-04-30T21:49:19.464Z, mtime: 2025-04-30T21:49:19.464Z, ctime: 2025-04-30T21:49:19.464Z, birthtime: 2025-04-30T21:49:19.464Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 { startTime: 54411653647791n, endTime: 54411653767875n, delta: 0.811767578125, allowableDelta: 1, preWriteHrtime: 54411653435333n, postWriteHrtime: 54411653647666n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108755, size: 4, blocks: 8, atimeMs: 1746049759466.8118, mtimeMs: 1746049759466.8733, ctimeMs: 1746049759466.8733, birthtimeMs: 1746049759466.8118, atime: 2025-04-30T21:49:19.467Z, mtime: 2025-04-30T21:49:19.467Z, ctime: 2025-04-30T21:49:19.467Z, birthtime: 2025-04-30T21:49:19.467Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108755n, size: 4n, blocks: 8n, atimeMs: 1746049759466n, mtimeMs: 1746049759466n, ctimeMs: 1746049759466n, birthtimeMs: 1746049759466n, atimeNs: 1746049759466811861n, mtimeNs: 1746049759466873236n, ctimeNs: 1746049759466873236n, birthtimeNs: 1746049759466811861n, atime: 2025-04-30T21:49:19.466Z, mtime: 2025-04-30T21:49:19.466Z, ctime: 2025-04-30T21:49:19.466Z, birthtime: 2025-04-30T21:49:19.466Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 { startTime: 54411654446666n, endTime: 54411654492375n, delta: 0.630859375, allowableDelta: 1, preWriteHrtime: 54411654171375n, postWriteHrtime: 54411654446625n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108756, size: 4, blocks: 8, atimeMs: 1746049759467.6309, mtimeMs: 1746049759467.7065, ctimeMs: 1746049759467.7065, birthtimeMs: 1746049759467.6309, atime: 2025-04-30T21:49:19.468Z, mtime: 2025-04-30T21:49:19.468Z, ctime: 2025-04-30T21:49:19.468Z, birthtime: 2025-04-30T21:49:19.468Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108756n, size: 4n, blocks: 8n, atimeMs: 1746049759467n, mtimeMs: 1746049759467n, ctimeMs: 1746049759467n, birthtimeMs: 1746049759467n, atimeNs: 1746049759467630739n, mtimeNs: 1746049759467706573n, ctimeNs: 1746049759467706573n, birthtimeNs: 1746049759467630739n, atime: 2025-04-30T21:49:19.467Z, mtime: 2025-04-30T21:49:19.467Z, ctime: 2025-04-30T21:49:19.467Z, birthtime: 2025-04-30T21:49:19.467Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 { startTime: 54411656420416n, endTime: 54411656448500n, delta: 0.519775390625, allowableDelta: 1, preWriteHrtime: 54411656164541n, postWriteHrtime: 54411656420375n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108757, size: 4, blocks: 8, atimeMs: 1746049759469.5198, mtimeMs: 1746049759469.6318, ctimeMs: 1746049759469.6318, birthtimeMs: 1746049759469.5198, atime: 2025-04-30T21:49:19.470Z, mtime: 2025-04-30T21:49:19.470Z, ctime: 2025-04-30T21:49:19.470Z, birthtime: 2025-04-30T21:49:19.470Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108757n, size: 4n, blocks: 8n, atimeMs: 1746049759469n, mtimeMs: 1746049759469n, ctimeMs: 1746049759469n, birthtimeMs: 1746049759469n, atimeNs: 1746049759469519788n, mtimeNs: 1746049759469631788n, ctimeNs: 1746049759469631788n, birthtimeNs: 1746049759469519788n, atime: 2025-04-30T21:49:19.469Z, mtime: 2025-04-30T21:49:19.469Z, ctime: 2025-04-30T21:49:19.469Z, birthtime: 2025-04-30T21:49:19.469Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 { startTime: 54411657279833n, endTime: 54411657289291n, delta: 0.354736328125, allowableDelta: 1, preWriteHrtime: 54411657017416n, postWriteHrtime: 54411657279791n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108758, size: 4, blocks: 8, atimeMs: 1746049759470.3547, mtimeMs: 1746049759470.4858, ctimeMs: 1746049759470.4858, birthtimeMs: 1746049759470.3547, atime: 2025-04-30T21:49:19.470Z, mtime: 2025-04-30T21:49:19.470Z, ctime: 2025-04-30T21:49:19.470Z, birthtime: 2025-04-30T21:49:19.470Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108758n, size: 4n, blocks: 8n, atimeMs: 1746049759470n, mtimeMs: 1746049759470n, ctimeMs: 1746049759470n, birthtimeMs: 1746049759470n, atimeNs: 1746049759470354708n, mtimeNs: 1746049759470485917n, ctimeNs: 1746049759470485917n, birthtimeNs: 1746049759470354708n, atime: 2025-04-30T21:49:19.470Z, mtime: 2025-04-30T21:49:19.470Z, ctime: 2025-04-30T21:49:19.470Z, birthtime: 2025-04-30T21:49:19.470Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 { startTime: 54411658287458n, endTime: 54411658470833n, delta: 0.2919921875, allowableDelta: 1, preWriteHrtime: 54411657971791n, postWriteHrtime: 54411658287416n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108759, size: 4, blocks: 8, atimeMs: 1746049759471.292, mtimeMs: 1746049759471.461, ctimeMs: 1746049759471.461, birthtimeMs: 1746049759471.292, atime: 2025-04-30T21:49:19.471Z, mtime: 2025-04-30T21:49:19.471Z, ctime: 2025-04-30T21:49:19.471Z, birthtime: 2025-04-30T21:49:19.471Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108759n, size: 4n, blocks: 8n, atimeMs: 1746049759471n, mtimeMs: 1746049759471n, ctimeMs: 1746049759471n, birthtimeMs: 1746049759471n, atimeNs: 1746049759471291961n, mtimeNs: 1746049759471460837n, ctimeNs: 1746049759471460837n, birthtimeNs: 1746049759471291961n, atime: 2025-04-30T21:49:19.471Z, mtime: 2025-04-30T21:49:19.471Z, ctime: 2025-04-30T21:49:19.471Z, birthtime: 2025-04-30T21:49:19.471Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 { startTime: 54411660085083n, endTime: 54411660237750n, delta: 0.175048828125, allowableDelta: 1, preWriteHrtime: 54411659850875n, postWriteHrtime: 54411660085041n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108760, size: 4, blocks: 8, atimeMs: 1746049759473.175, mtimeMs: 1746049759473.2864, ctimeMs: 1746049759473.2864, birthtimeMs: 1746049759473.175, atime: 2025-04-30T21:49:19.473Z, mtime: 2025-04-30T21:49:19.473Z, ctime: 2025-04-30T21:49:19.473Z, birthtime: 2025-04-30T21:49:19.473Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108760n, size: 4n, blocks: 8n, atimeMs: 1746049759473n, mtimeMs: 1746049759473n, ctimeMs: 1746049759473n, birthtimeMs: 1746049759473n, atimeNs: 1746049759473175093n, mtimeNs: 1746049759473286427n, ctimeNs: 1746049759473286427n, birthtimeNs: 1746049759473175093n, atime: 2025-04-30T21:49:19.473Z, mtime: 2025-04-30T21:49:19.473Z, ctime: 2025-04-30T21:49:19.473Z, birthtime: 2025-04-30T21:49:19.473Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 { startTime: 54411661401958n, endTime: 54411661471333n, delta: 0.407958984375, allowableDelta: 1, preWriteHrtime: 54411661078916n, postWriteHrtime: 54411661401791n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108761, size: 4, blocks: 8, atimeMs: 1746049759474.408, mtimeMs: 1746049759474.6155, ctimeMs: 1746049759474.6155, birthtimeMs: 1746049759474.408, atime: 2025-04-30T21:49:19.474Z, mtime: 2025-04-30T21:49:19.475Z, ctime: 2025-04-30T21:49:19.475Z, birthtime: 2025-04-30T21:49:19.474Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108761n, size: 4n, blocks: 8n, atimeMs: 1746049759474n, mtimeMs: 1746049759474n, ctimeMs: 1746049759474n, birthtimeMs: 1746049759474n, atimeNs: 1746049759474407973n, mtimeNs: 1746049759474615599n, ctimeNs: 1746049759474615599n, birthtimeNs: 1746049759474407973n, atime: 2025-04-30T21:49:19.474Z, mtime: 2025-04-30T21:49:19.474Z, ctime: 2025-04-30T21:49:19.474Z, birthtime: 2025-04-30T21:49:19.474Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 { startTime: 54411662743166n, endTime: 54411662790500n, delta: 0.482177734375, allowableDelta: 1, preWriteHrtime: 54411662083416n, postWriteHrtime: 54411662742791n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108762, size: 4, blocks: 8, atimeMs: 1746049759475.4822, mtimeMs: 1746049759475.6528, ctimeMs: 1746049759475.6528, birthtimeMs: 1746049759475.4822, atime: 2025-04-30T21:49:19.475Z, mtime: 2025-04-30T21:49:19.476Z, ctime: 2025-04-30T21:49:19.476Z, birthtime: 2025-04-30T21:49:19.475Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108762n, size: 4n, blocks: 8n, atimeMs: 1746049759475n, mtimeMs: 1746049759475n, ctimeMs: 1746049759475n, birthtimeMs: 1746049759475n, atimeNs: 1746049759475482227n, mtimeNs: 1746049759475652728n, ctimeNs: 1746049759475652728n, birthtimeNs: 1746049759475482227n, atime: 2025-04-30T21:49:19.475Z, mtime: 2025-04-30T21:49:19.475Z, ctime: 2025-04-30T21:49:19.475Z, birthtime: 2025-04-30T21:49:19.475Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 { startTime: 54411663530583n, endTime: 54411663543416n, delta: 0.645263671875, allowableDelta: 1, preWriteHrtime: 54411663269916n, postWriteHrtime: 54411663530375n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108763, size: 4, blocks: 8, atimeMs: 1746049759476.6453, mtimeMs: 1746049759476.78, ctimeMs: 1746049759476.78, birthtimeMs: 1746049759476.6453, atime: 2025-04-30T21:49:19.477Z, mtime: 2025-04-30T21:49:19.477Z, ctime: 2025-04-30T21:49:19.477Z, birthtime: 2025-04-30T21:49:19.477Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108763n, size: 4n, blocks: 8n, atimeMs: 1746049759476n, mtimeMs: 1746049759476n, ctimeMs: 1746049759476n, birthtimeMs: 1746049759476n, atimeNs: 1746049759476645274n, mtimeNs: 1746049759476779982n, ctimeNs: 1746049759476779982n, birthtimeNs: 1746049759476645274n, atime: 2025-04-30T21:49:19.476Z, mtime: 2025-04-30T21:49:19.476Z, ctime: 2025-04-30T21:49:19.476Z, birthtime: 2025-04-30T21:49:19.476Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 { startTime: 54411664065291n, endTime: 54411664095291n, delta: 0.124755859375, allowableDelta: 1, preWriteHrtime: 54411663753541n, postWriteHrtime: 54411664065166n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108764, size: 4, blocks: 8, atimeMs: 1746049759477.1248, mtimeMs: 1746049759477.296, ctimeMs: 1746049759477.296, birthtimeMs: 1746049759477.1248, atime: 2025-04-30T21:49:19.477Z, mtime: 2025-04-30T21:49:19.477Z, ctime: 2025-04-30T21:49:19.477Z, birthtime: 2025-04-30T21:49:19.477Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108764n, size: 4n, blocks: 8n, atimeMs: 1746049759477n, mtimeMs: 1746049759477n, ctimeMs: 1746049759477n, birthtimeMs: 1746049759477n, atimeNs: 1746049759477124734n, mtimeNs: 1746049759477295943n, ctimeNs: 1746049759477295943n, birthtimeNs: 1746049759477124734n, atime: 2025-04-30T21:49:19.477Z, mtime: 2025-04-30T21:49:19.477Z, ctime: 2025-04-30T21:49:19.477Z, birthtime: 2025-04-30T21:49:19.477Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 { startTime: 54411664854583n, endTime: 54411664867833n, delta: 0.81787109375, allowableDelta: 1, preWriteHrtime: 54411664459750n, postWriteHrtime: 54411664854541n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108765, size: 4, blocks: 8, atimeMs: 1746049759477.8179, mtimeMs: 1746049759477.9526, ctimeMs: 1746049759477.9526, birthtimeMs: 1746049759477.8179, atime: 2025-04-30T21:49:19.478Z, mtime: 2025-04-30T21:49:19.478Z, ctime: 2025-04-30T21:49:19.478Z, birthtime: 2025-04-30T21:49:19.478Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108765n, size: 4n, blocks: 8n, atimeMs: 1746049759477n, mtimeMs: 1746049759477n, ctimeMs: 1746049759477n, birthtimeMs: 1746049759477n, atimeNs: 1746049759477817861n, mtimeNs: 1746049759477952528n, ctimeNs: 1746049759477952528n, birthtimeNs: 1746049759477817861n, atime: 2025-04-30T21:49:19.477Z, mtime: 2025-04-30T21:49:19.477Z, ctime: 2025-04-30T21:49:19.477Z, birthtime: 2025-04-30T21:49:19.477Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6368 { startTime: 54411665527375n, endTime: 54411668296583n, delta: 3.380126953125, allowableDelta: 3, preWriteHrtime: 54411665106000n, postWriteHrtime: 54411665527375n, numStats: Stats { dev: 16777233, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420108766, size: 4, blocks: 8, atimeMs: 1746049759481.3801, mtimeMs: 1746049759478.6228, ctimeMs: 1746049759478.6228, birthtimeMs: 1746049759478.4778, atime: 2025-04-30T21:49:19.481Z, mtime: 2025-04-30T21:49:19.479Z, ctime: 2025-04-30T21:49:19.479Z, birthtime: 2025-04-30T21:49:19.478Z }, bigintStats: BigIntStats { dev: 16777233n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420108766n, size: 4n, blocks: 8n, atimeMs: 1746049759478n, mtimeMs: 1746049759478n, ctimeMs: 1746049759478n, birthtimeMs: 1746049759478n, atimeNs: 1746049759478477697n, mtimeNs: 1746049759478622864n, ctimeNs: 1746049759478622864n, birthtimeNs: 1746049759478477697n, atime: 2025-04-30T21:49:19.478Z, mtime: 2025-04-30T21:49:19.478Z, ctime: 2025-04-30T21:49:19.478Z, birthtime: 2025-04-30T21:49:19.478Z } } ==============================Last portion of `fs_usage` logs
22:49:19.460994 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 0.000038 node.1539297 22:49:19.461028 close F=18 0.000016 node.1539297 22:49:19.461036 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 0.000008 node.1539297 22:49:19.461069 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 0.000005 node.1539297 22:49:19.462219 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 0.000007 node.1539297 22:49:19.462223 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 0.000002 node.1539297 22:49:19.462306 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6353 0.000055 node.1539297 22:49:19.462822 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 0.000083 node.1539297 22:49:19.462875 close F=18 0.000024 node.1539297 22:49:19.462921 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 0.000009 node.1539297 22:49:19.462925 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 0.000002 node.1539297 22:49:19.463129 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 0.000004 node.1539297 22:49:19.463132 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 0.000002 node.1539297 22:49:19.463399 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6354 0.000141 node.1539297 22:49:19.463487 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 0.000061 node.1539297 22:49:19.463603 close F=18 0.000018 node.1539297 22:49:19.463648 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 0.000014 node.1539297 22:49:19.463671 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 0.000002 node.1539297 22:49:19.463958 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 0.000008 node.1539297 22:49:19.463961 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 0.000002 node.1539297 22:49:19.464006 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6355 0.000045 node.1539297 22:49:19.464334 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 0.000048 node.1539297 22:49:19.464491 close F=18 0.000057 node.1539297 22:49:19.464501 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 0.000008 node.1539297 22:49:19.464506 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 0.000002 node.1539297 22:49:19.466032 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 0.000014 node.1539297 22:49:19.466216 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 0.000005 node.1539297 22:49:19.466327 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6356 0.000094 node.1539297 22:49:19.466808 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 0.000115 node.1539297 22:49:19.466869 close F=18 0.000030 node.1539297 22:49:19.466909 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 0.000006 node.1539297 22:49:19.467017 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 0.000024 node.1539297 22:49:19.467167 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 0.000005 node.1539297 22:49:19.467213 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 0.000002 node.1539297 22:49:19.467272 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6357 0.000059 node.1539297 22:49:19.467624 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 0.000096 node.1539297 22:49:19.467700 close F=18 0.000027 node.1539297 22:49:19.467733 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 0.000008 node.1539297 22:49:19.467746 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 0.000004 node.1539297 22:49:19.469002 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 0.000008 node.1539297 22:49:19.469019 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 0.000007 node.1539297 22:49:19.469220 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6358 0.000071 node.1539297 22:49:19.469514 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 0.000094 node.1539297 22:49:19.469666 close F=18 0.000055 node.1539297 22:49:19.469682 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 0.000006 node.1539297 22:49:19.469702 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 0.000009 node.1539297 22:49:19.470044 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 0.000005 node.1539297 22:49:19.470048 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 0.000003 node.1539297 22:49:19.470179 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6359 0.000089 node.1539297 22:49:19.470349 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 0.000076 node.1539297 22:49:19.470532 close F=18 0.000048 node.1539297 22:49:19.470540 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 0.000004 node.1539297 22:49:19.470543 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 0.000002 node.1539297 22:49:19.470989 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 0.000003 node.1539297 22:49:19.470991 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 0.000002 node.1539297 22:49:19.471043 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6360 0.000052 node.1539297 22:49:19.471280 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 0.000052 node.1539297 22:49:19.471541 close F=18 0.000112 node.1539297 22:49:19.471574 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 0.000011 node.1539297 22:49:19.471723 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 0.000015 node.1539297 22:49:19.472922 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 0.000014 node.1539297 22:49:19.472926 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 0.000002 node.1539297 22:49:19.472996 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6361 0.000070 node.1539297 22:49:19.473168 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 0.000061 node.1539297 22:49:19.473311 close F=18 0.000057 node.1539297 22:49:19.473361 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 0.000015 node.1539297 22:49:19.473461 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 0.000017 node.1539297 22:49:19.473965 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 0.000008 node.1539297 22:49:19.474032 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 0.000022 node.1539297 22:49:19.474237 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6362 0.000197 node.1539297 22:49:19.474408 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 0.000074 node.1539297 22:49:19.474619 close F=18 0.000035 node.1539297 22:49:19.474720 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 0.000062 node.1539297 22:49:19.474725 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 0.000002 node.1539297 22:49:19.475165 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 0.000018 node.1539297 22:49:19.475186 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 0.000004 node.1539297 22:49:19.475252 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6363 0.000066 node.1539297 22:49:19.475544 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 0.000201 node.1539297 22:49:19.475943 close F=18 0.000105 node.1539297 22:49:19.476020 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 0.000020 node.1539297 22:49:19.476043 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 0.000016 node.1539297 22:49:19.476252 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 0.000018 node.1539297 22:49:19.476332 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 0.000016 node.1539297 22:49:19.476481 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6364 0.000146 node.1539297 22:49:19.476685 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 0.000158 node.1539297 22:49:19.476781 close F=18 0.000035 node.1539297 22:49:19.476793 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 0.000005 node.1539297 22:49:19.476797 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 0.000002 node.1539297 22:49:19.476873 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 0.000003 node.1539297 22:49:19.476876 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 0.000002 node.1539297 22:49:19.476941 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6365 0.000065 node.1539297 22:49:19.477153 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 0.000143 node.1539297 22:49:19.477318 close F=18 0.000055 node.1539297 22:49:19.477329 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 0.000008 node.1539297 22:49:19.477339 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 0.000006 node.1539297 22:49:19.477507 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 0.000006 node.1539297 22:49:19.477513 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 0.000004 node.1539297 22:49:19.477622 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6366 0.000107 node.1539297 22:49:19.477841 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 0.000124 node.1539297 22:49:19.478107 close F=18 0.000046 node.1539297 22:49:19.478117 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 0.000007 node.1539297 22:49:19.478122 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 0.000002 node.1539297 22:49:19.478183 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 0.000003 node.1539297 22:49:19.478186 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 0.000002 node.1539297 22:49:19.478246 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6367 0.000060 node.1539297 22:49:19.478505 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6368 0.000142 node.1539297 22:49:19.478750 close F=18 0.000139 node.1539297 22:49:19.478789 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6368 0.000006 node.1539297 22:49:19.481508 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_6368 0.000007 node.1539297 22:49:19.504137 close F=4 0.000009 node.1539297 22:49:19.504142 close F=5 0.000005 node.1539297 22:49:19.504196 close F=10 0.000003 node.1539299 22:49:19.504200 close F=9 0.000004 node.1539299 22:49:19.504204 close F=8 0.000004 node.1539299 22:49:19.504714 close F=7 0.000003 node.1539297 22:49:19.504717 close F=6 0.000003 node.1539297 22:49:19.504719 close F=3 0.000002 node.1539297it is hard to understand how these are relating to one another. It would help if we can see the numbers relative to the same reference like epoch or system time
Could you clarify what you mean? would just using
new Date().getTime()instead of process.hrtime to get the start and end times work for you?Yes, let's use
new Date().getTime().Let's keep the existing stats but also add
new Date().getTime()values at all the Xs:- X
- writeFileSync
- X
- statSync with bigint
- X
- statSync
- X
Done 🙂👍
Updated script
const fs = require("node:fs"); const path = require("node:path"); const assert = require("node:assert"); const { setTimeout } = require("node:timers/promises"); fs.rmSync("./tmp", { force: true, recursive: true }); console.error(`\x1b[32m This process' PID is: ${process.pid} (run: sudo fs_usage -w -f pathname ${process.pid} > fs_usage-logs.txt) \x1b[0m`); (async () => { await setTimeout(15_000); // a timeout so that fs_usage can be called fs.mkdirSync("./tmp"); const attempts = 100_000; const exitOnFail = true; for (let i = 0; i < attempts; i++) { const filename = path.resolve( `./tmp/test_${i}` ); console.error(`\x1b[35m processing ${filename} \x1b[0m`); try { const preWriteTime = new Date().getTime(); const preWriteHrtime = process.hrtime.bigint(); fs.writeFileSync(filename, "test"); const postWriteHrtime = process.hrtime.bigint(); const postWriteTime = new Date().getTime(); const startTime = process.hrtime.bigint(); const preBigintStatSyncTime = new Date().getTime(); const bigintStats = fs.statSync(filename, { bigint: true }); const postBigintStatSyncTime = new Date().getTime(); const preStatSyncTime = new Date().getTime(); const numStats = fs.statSync(filename); const postStatSyncTime = new Date().getTime(); const endTime = process.hrtime.bigint(); const allowableDelta = Math.ceil(Number(endTime - startTime) / 1e6); const key = "atimeMs"; const msFromBigInt = bigintStats[key]; const msFromNum = numStats[key]; console.log('==='.repeat(10)); console.log(filename); console.log({ startTime, endTime, delta: msFromNum - Number(msFromBigInt), allowableDelta, preWriteHrtime, postWriteHrtime, preWriteTime, postWriteTime, preBigintStatSyncTime, postBigintStatSyncTime, preStatSyncTime, postStatSyncTime, numStats, bigintStats, }); console.log('==='.repeat(10)); console.log('\n'.repeat(2)); assert( msFromNum - Number(msFromBigInt) <= allowableDelta, `Number version ${key} = ${msFromNum}, ` + `BigInt version ${key} = ${msFromBigInt}n, ` + `Delta = ${msFromNum - Number(msFromBigInt)}n, ` + `Allowable delta = ${allowableDelta}` ); fs.rmSync(filename); // remove the file if no flake occurred } catch (e) { if (e instanceof assert.AssertionError) { console.error(e); } if (exitOnFail) { throw e; } } } })();
Last portion of script output
Note: the assertion failed for
test_15319and succeeded for all the other files============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 { startTime: 13834844105625n, endTime: 13834844121416n, delta: 0.490234375, allowableDelta: 1, preWriteHrtime: 13834843979125n, postWriteHrtime: 13834844105083n, preWriteTime: 1746100376344, postWriteTime: 1746100376344, preBigintStatSyncTime: 1746100376344, postBigintStatSyncTime: 1746100376344, preStatSyncTime: 1746100376344, postStatSyncTime: 1746100376344, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425679, size: 4, blocks: 8, atimeMs: 1746100376344.4902, mtimeMs: 1746100376344.5444, ctimeMs: 1746100376344.5444, birthtimeMs: 1746100376344.4902, atime: 2025-05-01T11:52:56.344Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.344Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425679n, size: 4n, blocks: 8n, atimeMs: 1746100376344n, mtimeMs: 1746100376344n, ctimeMs: 1746100376344n, birthtimeMs: 1746100376344n, atimeNs: 1746100376344490117n, mtimeNs: 1746100376344544534n, ctimeNs: 1746100376344544534n, birthtimeNs: 1746100376344490117n, atime: 2025-05-01T11:52:56.344Z, mtime: 2025-05-01T11:52:56.344Z, ctime: 2025-05-01T11:52:56.344Z, birthtime: 2025-05-01T11:52:56.344Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 { startTime: 13834844404708n, endTime: 13834844417958n, delta: 0.784423828125, allowableDelta: 1, preWriteHrtime: 13834844284250n, postWriteHrtime: 13834844404333n, preWriteTime: 1746100376344, postWriteTime: 1746100376344, preBigintStatSyncTime: 1746100376344, postBigintStatSyncTime: 1746100376344, preStatSyncTime: 1746100376344, postStatSyncTime: 1746100376344, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425680, size: 4, blocks: 8, atimeMs: 1746100376344.7844, mtimeMs: 1746100376344.8464, ctimeMs: 1746100376344.8464, birthtimeMs: 1746100376344.7844, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425680n, size: 4n, blocks: 8n, atimeMs: 1746100376344n, mtimeMs: 1746100376344n, ctimeMs: 1746100376344n, birthtimeMs: 1746100376344n, atimeNs: 1746100376344784452n, mtimeNs: 1746100376344846369n, ctimeNs: 1746100376344846369n, birthtimeNs: 1746100376344784452n, atime: 2025-05-01T11:52:56.344Z, mtime: 2025-05-01T11:52:56.344Z, ctime: 2025-05-01T11:52:56.344Z, birthtime: 2025-05-01T11:52:56.344Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 { startTime: 13834844679416n, endTime: 13834844690583n, delta: 0.073486328125, allowableDelta: 1, preWriteHrtime: 13834844575333n, postWriteHrtime: 13834844679125n, preWriteTime: 1746100376345, postWriteTime: 1746100376345, preBigintStatSyncTime: 1746100376345, postBigintStatSyncTime: 1746100376345, preStatSyncTime: 1746100376345, postStatSyncTime: 1746100376345, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425681, size: 4, blocks: 8, atimeMs: 1746100376345.0735, mtimeMs: 1746100376345.1204, ctimeMs: 1746100376345.1204, birthtimeMs: 1746100376345.0735, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425681n, size: 4n, blocks: 8n, atimeMs: 1746100376345n, mtimeMs: 1746100376345n, ctimeMs: 1746100376345n, birthtimeMs: 1746100376345n, atimeNs: 1746100376345073495n, mtimeNs: 1746100376345120328n, ctimeNs: 1746100376345120328n, birthtimeNs: 1746100376345073495n, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 { startTime: 13834844950041n, endTime: 13834844961333n, delta: 0.34130859375, allowableDelta: 1, preWriteHrtime: 13834844843750n, postWriteHrtime: 13834844949791n, preWriteTime: 1746100376345, postWriteTime: 1746100376345, preBigintStatSyncTime: 1746100376345, postBigintStatSyncTime: 1746100376345, preStatSyncTime: 1746100376345, postStatSyncTime: 1746100376345, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425682, size: 4, blocks: 8, atimeMs: 1746100376345.3413, mtimeMs: 1746100376345.3918, ctimeMs: 1746100376345.3918, birthtimeMs: 1746100376345.3413, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425682n, size: 4n, blocks: 8n, atimeMs: 1746100376345n, mtimeMs: 1746100376345n, ctimeMs: 1746100376345n, birthtimeMs: 1746100376345n, atimeNs: 1746100376345341329n, mtimeNs: 1746100376345391871n, ctimeNs: 1746100376345391871n, birthtimeNs: 1746100376345341329n, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 { startTime: 13834845216750n, endTime: 13834845230666n, delta: 0.611572265625, allowableDelta: 1, preWriteHrtime: 13834845112833n, postWriteHrtime: 13834845216458n, preWriteTime: 1746100376345, postWriteTime: 1746100376345, preBigintStatSyncTime: 1746100376345, postBigintStatSyncTime: 1746100376345, preStatSyncTime: 1746100376345, postStatSyncTime: 1746100376345, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425683, size: 4, blocks: 8, atimeMs: 1746100376345.6116, mtimeMs: 1746100376345.6572, ctimeMs: 1746100376345.6572, birthtimeMs: 1746100376345.6116, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425683n, size: 4n, blocks: 8n, atimeMs: 1746100376345n, mtimeMs: 1746100376345n, ctimeMs: 1746100376345n, birthtimeMs: 1746100376345n, atimeNs: 1746100376345611455n, mtimeNs: 1746100376345657289n, ctimeNs: 1746100376345657289n, birthtimeNs: 1746100376345611455n, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 { startTime: 13834845490708n, endTime: 13834845498541n, delta: 0.88134765625, allowableDelta: 1, preWriteHrtime: 13834845372291n, postWriteHrtime: 13834845490333n, preWriteTime: 1746100376345, postWriteTime: 1746100376345, preBigintStatSyncTime: 1746100376345, postBigintStatSyncTime: 1746100376345, preStatSyncTime: 1746100376345, postStatSyncTime: 1746100376345, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425684, size: 4, blocks: 8, atimeMs: 1746100376345.8813, mtimeMs: 1746100376345.931, ctimeMs: 1746100376345.931, birthtimeMs: 1746100376345.8813, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425684n, size: 4n, blocks: 8n, atimeMs: 1746100376345n, mtimeMs: 1746100376345n, ctimeMs: 1746100376345n, birthtimeMs: 1746100376345n, atimeNs: 1746100376345881248n, mtimeNs: 1746100376345930915n, ctimeNs: 1746100376345930915n, birthtimeNs: 1746100376345881248n, atime: 2025-05-01T11:52:56.345Z, mtime: 2025-05-01T11:52:56.345Z, ctime: 2025-05-01T11:52:56.345Z, birthtime: 2025-05-01T11:52:56.345Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 { startTime: 13834845737000n, endTime: 13834845742916n, delta: 0.131103515625, allowableDelta: 1, preWriteHrtime: 13834845641750n, postWriteHrtime: 13834845736750n, preWriteTime: 1746100376346, postWriteTime: 1746100376346, preBigintStatSyncTime: 1746100376346, postBigintStatSyncTime: 1746100376346, preStatSyncTime: 1746100376346, postStatSyncTime: 1746100376346, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425685, size: 4, blocks: 8, atimeMs: 1746100376346.131, mtimeMs: 1746100376346.1797, ctimeMs: 1746100376346.1797, birthtimeMs: 1746100376346.131, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425685n, size: 4n, blocks: 8n, atimeMs: 1746100376346n, mtimeMs: 1746100376346n, ctimeMs: 1746100376346n, birthtimeMs: 1746100376346n, atimeNs: 1746100376346131040n, mtimeNs: 1746100376346179749n, ctimeNs: 1746100376346179749n, birthtimeNs: 1746100376346131040n, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 { startTime: 13834846012083n, endTime: 13834846053666n, delta: 0.395751953125, allowableDelta: 1, preWriteHrtime: 13834845894666n, postWriteHrtime: 13834846011833n, preWriteTime: 1746100376346, postWriteTime: 1746100376346, preBigintStatSyncTime: 1746100376346, postBigintStatSyncTime: 1746100376346, preStatSyncTime: 1746100376346, postStatSyncTime: 1746100376346, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425686, size: 4, blocks: 8, atimeMs: 1746100376346.3958, mtimeMs: 1746100376346.4517, ctimeMs: 1746100376346.4517, birthtimeMs: 1746100376346.3958, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425686n, size: 4n, blocks: 8n, atimeMs: 1746100376346n, mtimeMs: 1746100376346n, ctimeMs: 1746100376346n, birthtimeMs: 1746100376346n, atimeNs: 1746100376346395833n, mtimeNs: 1746100376346451709n, ctimeNs: 1746100376346451709n, birthtimeNs: 1746100376346395833n, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 { startTime: 13834846341125n, endTime: 13834846356208n, delta: 0.7216796875, allowableDelta: 1, preWriteHrtime: 13834846219833n, postWriteHrtime: 13834846340833n, preWriteTime: 1746100376346, postWriteTime: 1746100376346, preBigintStatSyncTime: 1746100376346, postBigintStatSyncTime: 1746100376346, preStatSyncTime: 1746100376346, postStatSyncTime: 1746100376346, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425687, size: 4, blocks: 8, atimeMs: 1746100376346.7217, mtimeMs: 1746100376346.7712, ctimeMs: 1746100376346.7712, birthtimeMs: 1746100376346.7217, atime: 2025-05-01T11:52:56.347Z, mtime: 2025-05-01T11:52:56.347Z, ctime: 2025-05-01T11:52:56.347Z, birthtime: 2025-05-01T11:52:56.347Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425687n, size: 4n, blocks: 8n, atimeMs: 1746100376346n, mtimeMs: 1746100376346n, ctimeMs: 1746100376346n, birthtimeMs: 1746100376346n, atimeNs: 1746100376346721710n, mtimeNs: 1746100376346771168n, ctimeNs: 1746100376346771168n, birthtimeNs: 1746100376346721710n, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.346Z, ctime: 2025-05-01T11:52:56.346Z, birthtime: 2025-05-01T11:52:56.346Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 { startTime: 13834846559291n, endTime: 13834846569750n, delta: 0.96337890625, allowableDelta: 1, preWriteHrtime: 13834846468041n, postWriteHrtime: 13834846559000n, preWriteTime: 1746100376346, postWriteTime: 1746100376347, preBigintStatSyncTime: 1746100376347, postBigintStatSyncTime: 1746100376347, preStatSyncTime: 1746100376347, postStatSyncTime: 1746100376347, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425688, size: 4, blocks: 8, atimeMs: 1746100376346.9634, mtimeMs: 1746100376347.0012, ctimeMs: 1746100376347.0012, birthtimeMs: 1746100376346.9634, atime: 2025-05-01T11:52:56.347Z, mtime: 2025-05-01T11:52:56.347Z, ctime: 2025-05-01T11:52:56.347Z, birthtime: 2025-05-01T11:52:56.347Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425688n, size: 4n, blocks: 8n, atimeMs: 1746100376346n, mtimeMs: 1746100376347n, ctimeMs: 1746100376347n, birthtimeMs: 1746100376346n, atimeNs: 1746100376346963336n, mtimeNs: 1746100376347001169n, ctimeNs: 1746100376347001169n, birthtimeNs: 1746100376346963336n, atime: 2025-05-01T11:52:56.346Z, mtime: 2025-05-01T11:52:56.347Z, ctime: 2025-05-01T11:52:56.347Z, birthtime: 2025-05-01T11:52:56.346Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 { startTime: 13834846783458n, endTime: 13834846793000n, delta: 0.183837890625, allowableDelta: 1, preWriteHrtime: 13834846683333n, postWriteHrtime: 13834846783208n, preWriteTime: 1746100376347, postWriteTime: 1746100376347, preBigintStatSyncTime: 1746100376347, postBigintStatSyncTime: 1746100376347, preStatSyncTime: 1746100376347, postStatSyncTime: 1746100376347, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425689, size: 4, blocks: 8, atimeMs: 1746100376347.1838, mtimeMs: 1746100376347.2246, ctimeMs: 1746100376347.2246, birthtimeMs: 1746100376347.1838, atime: 2025-05-01T11:52:56.347Z, mtime: 2025-05-01T11:52:56.347Z, ctime: 2025-05-01T11:52:56.347Z, birthtime: 2025-05-01T11:52:56.347Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425689n, size: 4n, blocks: 8n, atimeMs: 1746100376347n, mtimeMs: 1746100376347n, ctimeMs: 1746100376347n, birthtimeMs: 1746100376347n, atimeNs: 1746100376347183753n, mtimeNs: 1746100376347224587n, ctimeNs: 1746100376347224587n, birthtimeNs: 1746100376347183753n, atime: 2025-05-01T11:52:56.347Z, mtime: 2025-05-01T11:52:56.347Z, ctime: 2025-05-01T11:52:56.347Z, birthtime: 2025-05-01T11:52:56.347Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 { startTime: 13834847330416n, endTime: 13834847342458n, delta: 0.718994140625, allowableDelta: 1, preWriteHrtime: 13834847213291n, postWriteHrtime: 13834847330083n, preWriteTime: 1746100376347, postWriteTime: 1746100376347, preBigintStatSyncTime: 1746100376347, postBigintStatSyncTime: 1746100376347, preStatSyncTime: 1746100376347, postStatSyncTime: 1746100376347, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425690, size: 4, blocks: 8, atimeMs: 1746100376347.719, mtimeMs: 1746100376347.7705, ctimeMs: 1746100376347.7705, birthtimeMs: 1746100376347.719, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425690n, size: 4n, blocks: 8n, atimeMs: 1746100376347n, mtimeMs: 1746100376347n, ctimeMs: 1746100376347n, birthtimeMs: 1746100376347n, atimeNs: 1746100376347719047n, mtimeNs: 1746100376347770506n, ctimeNs: 1746100376347770506n, birthtimeNs: 1746100376347719047n, atime: 2025-05-01T11:52:56.347Z, mtime: 2025-05-01T11:52:56.347Z, ctime: 2025-05-01T11:52:56.347Z, birthtime: 2025-05-01T11:52:56.347Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 { startTime: 13834847561250n, endTime: 13834847572041n, delta: 0.96923828125, allowableDelta: 1, preWriteHrtime: 13834847471375n, postWriteHrtime: 13834847560916n, preWriteTime: 1746100376347, postWriteTime: 1746100376348, preBigintStatSyncTime: 1746100376348, postBigintStatSyncTime: 1746100376348, preStatSyncTime: 1746100376348, postStatSyncTime: 1746100376348, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425691, size: 4, blocks: 8, atimeMs: 1746100376347.9692, mtimeMs: 1746100376348.0068, ctimeMs: 1746100376348.0068, birthtimeMs: 1746100376347.9692, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425691n, size: 4n, blocks: 8n, atimeMs: 1746100376347n, mtimeMs: 1746100376348n, ctimeMs: 1746100376348n, birthtimeMs: 1746100376347n, atimeNs: 1746100376347969298n, mtimeNs: 1746100376348006798n, ctimeNs: 1746100376348006798n, birthtimeNs: 1746100376347969298n, atime: 2025-05-01T11:52:56.347Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.347Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 { startTime: 13834847762083n, endTime: 13834847773500n, delta: 0.172607421875, allowableDelta: 1, preWriteHrtime: 13834847681041n, postWriteHrtime: 13834847761833n, preWriteTime: 1746100376348, postWriteTime: 1746100376348, preBigintStatSyncTime: 1746100376348, postBigintStatSyncTime: 1746100376348, preStatSyncTime: 1746100376348, postStatSyncTime: 1746100376348, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425692, size: 4, blocks: 8, atimeMs: 1746100376348.1726, mtimeMs: 1746100376348.2095, ctimeMs: 1746100376348.2095, birthtimeMs: 1746100376348.1726, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425692n, size: 4n, blocks: 8n, atimeMs: 1746100376348n, mtimeMs: 1746100376348n, ctimeMs: 1746100376348n, birthtimeMs: 1746100376348n, atimeNs: 1746100376348172674n, mtimeNs: 1746100376348209549n, ctimeNs: 1746100376348209549n, birthtimeNs: 1746100376348172674n, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 { startTime: 13834848033791n, endTime: 13834848047791n, delta: 0.40673828125, allowableDelta: 1, preWriteHrtime: 13834847889666n, postWriteHrtime: 13834848033208n, preWriteTime: 1746100376348, postWriteTime: 1746100376348, preBigintStatSyncTime: 1746100376348, postBigintStatSyncTime: 1746100376348, preStatSyncTime: 1746100376348, postStatSyncTime: 1746100376348, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425693, size: 4, blocks: 8, atimeMs: 1746100376348.4067, mtimeMs: 1746100376348.4504, ctimeMs: 1746100376348.4504, birthtimeMs: 1746100376348.4067, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425693n, size: 4n, blocks: 8n, atimeMs: 1746100376348n, mtimeMs: 1746100376348n, ctimeMs: 1746100376348n, birthtimeMs: 1746100376348n, atimeNs: 1746100376348406717n, mtimeNs: 1746100376348450550n, ctimeNs: 1746100376348450550n, birthtimeNs: 1746100376348406717n, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 { startTime: 13834848338041n, endTime: 13834848349208n, delta: 0.718994140625, allowableDelta: 1, preWriteHrtime: 13834848224208n, postWriteHrtime: 13834848337750n, preWriteTime: 1746100376348, postWriteTime: 1746100376348, preBigintStatSyncTime: 1746100376348, postBigintStatSyncTime: 1746100376348, preStatSyncTime: 1746100376348, postStatSyncTime: 1746100376348, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425694, size: 4, blocks: 8, atimeMs: 1746100376348.719, mtimeMs: 1746100376348.7747, ctimeMs: 1746100376348.7747, birthtimeMs: 1746100376348.719, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425694n, size: 4n, blocks: 8n, atimeMs: 1746100376348n, mtimeMs: 1746100376348n, ctimeMs: 1746100376348n, birthtimeMs: 1746100376348n, atimeNs: 1746100376348718968n, mtimeNs: 1746100376348774760n, ctimeNs: 1746100376348774760n, birthtimeNs: 1746100376348718968n, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.348Z, ctime: 2025-05-01T11:52:56.348Z, birthtime: 2025-05-01T11:52:56.348Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 { startTime: 13834848606375n, endTime: 13834848614708n, delta: 0.988525390625, allowableDelta: 1, preWriteHrtime: 13834848489791n, postWriteHrtime: 13834848606125n, preWriteTime: 1746100376348, postWriteTime: 1746100376349, preBigintStatSyncTime: 1746100376349, postBigintStatSyncTime: 1746100376349, preStatSyncTime: 1746100376349, postStatSyncTime: 1746100376349, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425695, size: 4, blocks: 8, atimeMs: 1746100376348.9885, mtimeMs: 1746100376349.0454, ctimeMs: 1746100376349.0454, birthtimeMs: 1746100376348.9885, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425695n, size: 4n, blocks: 8n, atimeMs: 1746100376348n, mtimeMs: 1746100376349n, ctimeMs: 1746100376349n, birthtimeMs: 1746100376348n, atimeNs: 1746100376348988428n, mtimeNs: 1746100376349045303n, ctimeNs: 1746100376349045303n, birthtimeNs: 1746100376348988428n, atime: 2025-05-01T11:52:56.348Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.348Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 { startTime: 13834848788958n, endTime: 13834848797291n, delta: 0.202392578125, allowableDelta: 1, preWriteHrtime: 13834848714458n, postWriteHrtime: 13834848788750n, preWriteTime: 1746100376349, postWriteTime: 1746100376349, preBigintStatSyncTime: 1746100376349, postBigintStatSyncTime: 1746100376349, preStatSyncTime: 1746100376349, postStatSyncTime: 1746100376349, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425696, size: 4, blocks: 8, atimeMs: 1746100376349.2024, mtimeMs: 1746100376349.2366, ctimeMs: 1746100376349.2366, birthtimeMs: 1746100376349.2024, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425696n, size: 4n, blocks: 8n, atimeMs: 1746100376349n, mtimeMs: 1746100376349n, ctimeMs: 1746100376349n, birthtimeMs: 1746100376349n, atimeNs: 1746100376349202470n, mtimeNs: 1746100376349236679n, ctimeNs: 1746100376349236679n, birthtimeNs: 1746100376349202470n, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 { startTime: 13834848957416n, endTime: 13834848964958n, delta: 0.375, allowableDelta: 1, preWriteHrtime: 13834848887083n, postWriteHrtime: 13834848957208n, preWriteTime: 1746100376349, postWriteTime: 1746100376349, preBigintStatSyncTime: 1746100376349, postBigintStatSyncTime: 1746100376349, preStatSyncTime: 1746100376349, postStatSyncTime: 1746100376349, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425697, size: 4, blocks: 8, atimeMs: 1746100376349.375, mtimeMs: 1746100376349.4053, ctimeMs: 1746100376349.4053, birthtimeMs: 1746100376349.375, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425697n, size: 4n, blocks: 8n, atimeMs: 1746100376349n, mtimeMs: 1746100376349n, ctimeMs: 1746100376349n, birthtimeMs: 1746100376349n, atimeNs: 1746100376349374971n, mtimeNs: 1746100376349405388n, ctimeNs: 1746100376349405388n, birthtimeNs: 1746100376349374971n, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 { startTime: 13834849153375n, endTime: 13834849164833n, delta: 0.562744140625, allowableDelta: 1, preWriteHrtime: 13834849068291n, postWriteHrtime: 13834849153166n, preWriteTime: 1746100376349, postWriteTime: 1746100376349, preBigintStatSyncTime: 1746100376349, postBigintStatSyncTime: 1746100376349, preStatSyncTime: 1746100376349, postStatSyncTime: 1746100376349, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425698, size: 4, blocks: 8, atimeMs: 1746100376349.5627, mtimeMs: 1746100376349.598, ctimeMs: 1746100376349.598, birthtimeMs: 1746100376349.5627, atime: 2025-05-01T11:52:56.350Z, mtime: 2025-05-01T11:52:56.350Z, ctime: 2025-05-01T11:52:56.350Z, birthtime: 2025-05-01T11:52:56.350Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425698n, size: 4n, blocks: 8n, atimeMs: 1746100376349n, mtimeMs: 1746100376349n, ctimeMs: 1746100376349n, birthtimeMs: 1746100376349n, atimeNs: 1746100376349562722n, mtimeNs: 1746100376349597805n, ctimeNs: 1746100376349597805n, birthtimeNs: 1746100376349562722n, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z } } ============================== ============================== /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15319 { startTime: 13834849353916n, endTime: 13834850787250n, delta: 2.151611328125, allowableDelta: 2, preWriteHrtime: 13834849262666n, postWriteHrtime: 13834849353666n, preWriteTime: 1746100376349, postWriteTime: 1746100376349, preBigintStatSyncTime: 1746100376349, postBigintStatSyncTime: 1746100376351, preStatSyncTime: 1746100376351, postStatSyncTime: 1746100376351, numStats: Stats { dev: 16777230, mode: 33188, nlink: 1, uid: 502, gid: 20, rdev: 0, blksize: 4096, ino: 420425699, size: 4, blocks: 8, atimeMs: 1746100376351.1516, mtimeMs: 1746100376349.7966, ctimeMs: 1746100376349.7966, birthtimeMs: 1746100376349.7595, atime: 2025-05-01T11:52:56.351Z, mtime: 2025-05-01T11:52:56.350Z, ctime: 2025-05-01T11:52:56.350Z, birthtime: 2025-05-01T11:52:56.350Z }, bigintStats: BigIntStats { dev: 16777230n, mode: 33188n, nlink: 1n, uid: 502n, gid: 20n, rdev: 0n, blksize: 4096n, ino: 420425699n, size: 4n, blocks: 8n, atimeMs: 1746100376349n, mtimeMs: 1746100376349n, ctimeMs: 1746100376349n, birthtimeMs: 1746100376349n, atimeNs: 1746100376349759597n, mtimeNs: 1746100376349796514n, ctimeNs: 1746100376349796514n, birthtimeNs: 1746100376349759597n, atime: 2025-05-01T11:52:56.349Z, mtime: 2025-05-01T11:52:56.349Z, ctime: 2025-05-01T11:52:56.349Z, birthtime: 2025-05-01T11:52:56.349Z } } ==============================Last portion of `fs_usage` logs
12:52:56.344519 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 0.000082 node.333978 12:52:56.344562 close F=18 0.000020 node.333978 12:52:56.344574 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 0.000010 node.333978 12:52:56.344578 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 0.000003 node.333978 12:52:56.344662 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 0.000010 node.333978 12:52:56.344665 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 0.000002 node.333978 12:52:56.344731 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15299 0.000066 node.333978 12:52:56.344810 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 0.000068 node.333978 12:52:56.344861 close F=18 0.000018 node.333978 12:52:56.344872 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 0.000009 node.333978 12:52:56.344875 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 0.000002 node.333978 12:52:56.344959 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 0.000009 node.333978 12:52:56.344961 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 0.000002 node.333978 12:52:56.345024 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15300 0.000062 node.333978 12:52:56.345097 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 0.000064 node.333978 12:52:56.345136 close F=18 0.000019 node.333978 12:52:56.345145 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 0.000008 node.333978 12:52:56.345147 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 0.000002 node.333978 12:52:56.345222 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 0.000009 node.333978 12:52:56.345224 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 0.000002 node.333978 12:52:56.345292 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15301 0.000068 node.333978 12:52:56.345367 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 0.000065 node.333978 12:52:56.345407 close F=18 0.000018 node.333978 12:52:56.345415 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 0.000008 node.333978 12:52:56.345418 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 0.000002 node.333978 12:52:56.345491 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 0.000009 node.333978 12:52:56.345495 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 0.000003 node.333978 12:52:56.345562 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15302 0.000067 node.333978 12:52:56.345632 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 0.000061 node.333978 12:52:56.345673 close F=18 0.000019 node.333978 12:52:56.345684 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 0.000010 node.333978 12:52:56.345688 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 0.000003 node.333978 12:52:56.345761 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 0.000008 node.333978 12:52:56.345763 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 0.000002 node.333978 12:52:56.345821 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15303 0.000058 node.333978 12:52:56.345904 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 0.000074 node.333978 12:52:56.345947 close F=18 0.000019 node.333978 12:52:56.345953 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 0.000004 node.333978 12:52:56.345955 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 0.000002 node.333978 12:52:56.346031 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 0.000003 node.333978 12:52:56.346033 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 0.000002 node.333978 12:52:56.346089 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15304 0.000056 node.333978 12:52:56.346152 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 0.000052 node.333978 12:52:56.346194 close F=18 0.000018 node.333978 12:52:56.346197 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 0.000003 node.333978 12:52:56.346200 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 0.000002 node.333978 12:52:56.346272 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 0.000010 node.333978 12:52:56.346275 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 0.000002 node.333978 12:52:56.346342 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15305 0.000067 node.333978 12:52:56.346426 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 0.000074 node.333978 12:52:56.346469 close F=18 0.000020 node.333978 12:52:56.346480 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 0.000011 node.333978 12:52:56.346510 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 0.000015 node.333978 12:52:56.346583 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 0.000010 node.333978 12:52:56.346586 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 0.000002 node.333978 12:52:56.346663 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15306 0.000077 node.333978 12:52:56.346751 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 0.000072 node.333978 12:52:56.346798 close F=18 0.000030 node.333978 12:52:56.346810 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 0.000011 node.333978 12:52:56.346813 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 0.000002 node.333978 12:52:56.346868 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 0.000008 node.333978 12:52:56.346870 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 0.000002 node.333978 12:52:56.346918 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15307 0.000047 node.333978 12:52:56.346984 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 0.000058 node.333978 12:52:56.347016 close F=18 0.000019 node.333978 12:52:56.347024 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 0.000007 node.333978 12:52:56.347027 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 0.000002 node.333978 12:52:56.347083 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 0.000008 node.333978 12:52:56.347086 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 0.000002 node.333978 12:52:56.347134 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15308 0.000047 node.333978 12:52:56.347207 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 0.000066 node.333978 12:52:56.347240 close F=18 0.000019 node.333978 12:52:56.347247 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 0.000006 node.333978 12:52:56.347250 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 0.000002 node.333978 12:52:56.347298 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 0.000004 node.333978 12:52:56.347300 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 0.000002 node.333978 12:52:56.347653 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15309 0.000353 node.333978 12:52:56.347745 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 0.000074 node.333978 12:52:56.347787 close F=18 0.000020 node.333978 12:52:56.347796 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 0.000008 node.333978 12:52:56.347799 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 0.000002 node.333978 12:52:56.347867 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 0.000015 node.333978 12:52:56.347870 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 0.000002 node.333978 12:52:56.347918 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15310 0.000048 node.333978 12:52:56.347989 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 0.000060 node.333978 12:52:56.348018 close F=18 0.000015 node.333978 12:52:56.348026 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 0.000007 node.333978 12:52:56.348029 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 0.000002 node.333978 12:52:56.348082 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 0.000010 node.333978 12:52:56.348085 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 0.000003 node.333978 12:52:56.348130 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15311 0.000044 node.333978 12:52:56.348192 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 0.000053 node.333978 12:52:56.348219 close F=18 0.000013 node.333978 12:52:56.348227 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 0.000007 node.333978 12:52:56.348230 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 0.000003 node.333978 12:52:56.348285 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 0.000007 node.333978 12:52:56.348287 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 0.000002 node.333978 12:52:56.348337 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15312 0.000050 node.333978 12:52:56.348430 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 0.000083 node.333978 12:52:56.348490 close F=18 0.000033 node.333978 12:52:56.348500 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 0.000009 node.333978 12:52:56.348505 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 0.000004 node.333978 12:52:56.348586 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 0.000011 node.333978 12:52:56.348593 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 0.000006 node.333978 12:52:56.348672 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15313 0.000079 node.333978 12:52:56.348747 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 0.000065 node.333978 12:52:56.348795 close F=18 0.000023 node.333978 12:52:56.348803 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 0.000008 node.333978 12:52:56.348806 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 0.000002 node.333978 12:52:56.348865 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 0.000010 node.333978 12:52:56.348867 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 0.000002 node.333978 12:52:56.348937 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15314 0.000069 node.333978 12:52:56.349015 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 0.000067 node.333978 12:52:56.349063 close F=18 0.000021 node.333978 12:52:56.349069 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 0.000005 node.333978 12:52:56.349072 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 0.000002 node.333978 12:52:56.349121 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 0.000006 node.333978 12:52:56.349124 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 0.000002 node.333978 12:52:56.349162 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15315 0.000039 node.333978 12:52:56.349220 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 0.000048 node.333978 12:52:56.349246 close F=18 0.000013 node.333978 12:52:56.349251 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 0.000004 node.333978 12:52:56.349254 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 0.000002 node.333978 12:52:56.349299 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 0.000005 node.333978 12:52:56.349301 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 0.000002 node.333978 12:52:56.349335 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15316 0.000034 node.333978 12:52:56.349389 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 0.000045 node.333978 12:52:56.349414 close F=18 0.000013 node.333978 12:52:56.349419 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 0.000004 node.333978 12:52:56.349422 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 0.000002 node.333978 12:52:56.349472 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 0.000007 node.333978 12:52:56.349475 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 0.000002 node.333978 12:52:56.349516 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15317 0.000041 node.333978 12:52:56.349581 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 0.000055 node.333978 12:52:56.349610 close F=18 0.000015 node.333978 12:52:56.349617 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 0.000006 node.333978 12:52:56.349622 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 0.000004 node.333978 12:52:56.349664 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 0.000003 node.333978 12:52:56.349666 lstat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 0.000002 node.333978 12:52:56.349710 unlink /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15318 0.000044 node.333978 12:52:56.349780 open F=18 (_WC_T______X__) /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15319 0.000059 node.333978 12:52:56.349811 close F=18 0.000018 node.333978 12:52:56.349826 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15319 0.000014 node.333978 12:52:56.351210 stat64 /Users/dario/Repos/dario-piotrowicz/my-node-tests/issues/45612_test-fs-stat-bigint-flaky-on-macos-m1/tmp/test_15319 0.000015 node.333978 12:52:56.355548 close F=4 0.000003 node.333978 12:52:56.355551 close F=5 0.000003 node.333978 12:52:56.355573 close F=10 0.000001 node.334037 12:52:56.355575 close F=9 0.000002 node.334037 12:52:56.355577 close F=8 0.000002 node.334037 12:52:56.356727 close F=7 0.000002 node.333978 12:52:56.356729 close F=6 0.000003 node.333978 12:52:56.356731 close F=3 0.000002 node.333978preBigintStatSyncTime: 1746100376349, postBigintStatSyncTime: 1746100376351,interesting! 👀
My observations:
For the failed case:
a. atimeNs on first stat: ...49759597
b. atimeMs on first stat: ...49
c. atimeMs on second stat: ...51.1516- We see a 0.759597ms difference between the atimeMs and atimeNs values on the first bigint stat object because the atimeMs value is calculated by doing integer division with kNsPerMsBigInt which is 10n ** 6n:
Lines 500 to 503 in fc054bb
this.atimeMs = atimeNs / kNsPerMsBigInt; this.mtimeMs = mtimeNs / kNsPerMsBigInt; this.ctimeMs = ctimeNs / kNsPerMsBigInt; this.birthtimeMs = birthtimeNs / kNsPerMsBigInt;
This floors the value. - The accurate difference between atime on the second stat object (c) and the first stat object (a) is ...51.1516 ms - ...49.759597 ms = 1.392 ms. This is within the allowed delta without ceil = 13834850.787250 ms - 13834849.353916 ms = 1.433334ms. It only goes out of range when you compare the atime on the second stat object (c) with the floored atime on the first object (b), which is ...51.1516 ms - ...49 ms = 2.152 ms.
- All the (birth|m|c)time values are exactly the same, except for the flooring differences discussed above.
- As you pointed out, there is a 2ms gap before and after the first stat call for the failing case but it is 0ms for all the other cases. The new atime after this stat call looks similar to the timestamp after this stat call completed. I would not blame the stat for the atime update because you can still run the stat call on the same file on the REPL after wide intervals and it would not update the atime. Also, correlation does not imply causation. So this part is still an unsolved mystery.
My suggestions:
- For 1 and 2, we can modify the calculation to account for the flooring difference.
- For 3, the test can be modified to just allow the flooring difference for (birth|m|c)time values, i.e., no additional delta needed.
- For 4, you can use Apple's Endpoint Security APIs, not sure which one:
https://developer.apple.com/documentation/endpointsecurity/es_event_type_auth_utimes
https://developer.apple.com/documentation/endpointsecurity/es_event_type_notify_utimes
to see if it allows you to detect what process is causing the atime change. If you're able to create a program that can detect one such case successfully but it's not able to detect any in this case, the conclusion is that it's just APFS acting crazy.
- We see a 0.759597ms difference between the atimeMs and atimeNs values on the first bigint stat object because the atimeMs value is calculated by doing integer division with kNsPerMsBigInt which is 10n ** 6n:
Hi @RaisinTen, sorry for the late reply 🙇
Thanks a lot for the detailed answer, for points 1,2 and 3 I've applied the following changes: dario-piotrowicz@4f913fb
Is this what you had in mind?
This seems to be working fine on my mac but:
- it significantly increases the atime related flakiness (to a degree that I think is definitely not acceptable unfortunately)
- even without atime it still presents some slight flakiness for mtime
Regarding point 4, that's definitely outside my area of expertise but I'll try to have a look 🙏
No worries, I had a busy week too. ;)
@dario-piotrowicz your changes look sensible to me.
The atime flake is still expected because of the unsolved mystery, so the delta is still needed for this but I didn't expect the mtime to change at all.
Apparently, you don't need to write an Endpoint Security client yourself because I found out about eslogger which should already exist on your system. You can try to run that in parallel (your terminal would need full disk access):
$ sudo eslogger access create open close stat utimes write | jq -r '"\(.process.executable.path) -> \(.event)"' | grep path-of-the-fileand it would print info about what process is performing the syscalls and a JSON with event info about the syscall along with the file stat data. This should show which process is responsible for suddenly modifying these times.
github-actions commented
on Jun 23, 2026 on Jun 23, 2026 – with GitHub ActionsContributorMore actionsThis issue has been marked as stale due to 210 days of inactivity.
It will be automatically closed in 30 days if no further activity occurs. If this is still relevant, please leave a comment or update it to keep it open.- addedstaleIssues and PRs marked stale due to inactivity and scheduled for automatic closure.Issues and PRs marked stale due to inactivity and scheduled for automatic closure.
on Jun 23, 2026 github-actions commented
on Jul 24, 2026 on Jul 24, 2026 – with GitHub ActionsContributorMore actionsThis issue has been automatically closed after 30 days of inactivity following its stale status (no activity for a total of 120 days).
If this is still relevant, feel free to reopen it or leave a comment with additional details so we can continue the discussion.
Test
test-fs-stat-bigint
Platform
macOS ARM64
Console output
Build links
Additional information
Failing consistently when running about 50 times in parallel execution, e.g:
hyperfine -m 50 "out/Release/node test/parallel/test-fs-stat-bigint.js"