Investigate flaky addons/stringbytes-external-exceed-max/test-stringbytes-external-exceed-max-by-1-binary on FreeBSD 11
[iojs@test-digitalocean-freebsd11-x64-2 /usr/home/iojs/build/workspace/node-test-commit-freebsd/nodes/freebsd11-x64]$ time ./node --trace_gc --trace_gc_verbose test/addons/stringbytes-external-exceed-max/test-stringbytes-external-exceed-max-by-1-bina
ryjs
[85803:0x803e34380] Shrinking page 0x162787d00000: end 0x162787d80000 -> 0x162787d39000
[85803:0x803e34380] Shrinking page 0x1d2c15f00000: end 0x1d2c15f80000 -> 0x1d2c15f03000
[85803:0x803e34380] Fast promotion mode: false survival rate: 71%
[85803:0x803e34380] 62 ms: Scavenge 2.6 (4.2) -> 2.3 (5.2) MB, 1.8 / 0.0 ms (average mu = 1.000, current mu = 1.000) allocation failure
[85803:0x803e34380] Memory allocator, used: 5360 KB, available: 1486096 KB
[85803:0x803e34380] Read-only space, used: 34 KB, available: 469 KB, committed: 512 KB
[85803:0x803e34380] New space, used: 748 KB, available: 258 KB, committed: 2048 KB
[85803:0x803e34380] Old space, used: 919 KB, available: 0 KB, committed: 1252 KB
[85803:0x803e34380] Code space, used: 475 KB, available: 0 KB, committed: 1024KB
[85803:0x803e34380] Map space, used: 213 KB, available: 0 KB, committed: 524 KB
[85803:0x803e34380] Large object space, used: 0 KB, available: 1485575 KB, committed: 0 KB
[85803:0x803e34380] All spaces, used: 2390 KB, available: 1486303 KB, committed: 5360KB
[85803:0x803e34380] External memory reported: 8 KB
[85803:0x803e34380] External memory global 0 KB
[85803:0x803e34380] Total time spent in GC : 1.8 ms
[85803:0x803e34380] Fast promotion mode: false survival rate: 87%
[85803:0x803e34380] 77 ms: Scavenge 2.8 (5.2) -> 2.7 (6.2) MB, 1.9 / 0.0 ms (average mu = 1.000, current mu = 1.000) allocation failure
[85803:0x803e34380] Memory allocator, used: 6384 KB, available: 1485072 KB
[85803:0x803e34380] Read-only space, used: 34 KB, available: 469 KB, committed: 512 KB
[85803:0x803e34380] New space, used: 192 KB, available: 814 KB, committed: 2048 KB
[85803:0x803e34380] Old space, used: 1751 KB, available: 290 KB, committed: 2276 KB
[85803:0x803e34380] Code space, used: 490 KB, available: 0 KB, committed: 1024KB
[85803:0x803e34380] Map space, used: 266 KB, available: 0 KB, committed: 524 KB
[85803:0x803e34380] Large object space, used: 0 KB, available: 1484551 KB, committed: 0 KB
[85803:0x803e34380] All spaces, used: 2735 KB, available: 1486125 KB, committed: 6384KB
[85803:0x803e34380] External memory reported: 8 KB
[85803:0x803e34380] External memory global 0 KB
[85803:0x803e34380] Total time spent in GC : 3.7 ms
[85803:0x803e34380] Fast promotion mode: false survival rate: 39%
[85803:0x803e34380] 141 ms: Scavenge 4.2 (6.7) -> 4.0 (9.7) MB, 1.3 / 0.0 ms (average mu = 1.000, current mu = 1.000) allocation failure
[85803:0x803e34380] Memory allocator, used: 9968 KB, available: 1481488 KB
[85803:0x803e34380] Read-only space, used: 34 KB, available: 469 KB, committed: 512 KB
[85803:0x803e34380] New space, used: 673 KB, available: 1340 KB, committed: 4096 KB
[85803:0x803e34380] Old space, used: 2544 KB, available: 889 KB, committed: 3812 KB
[85803:0x803e34380] Code space, used: 541 KB, available: 0 KB, committed: 1024KB
[85803:0x803e34380] Map space, used: 328 KB, available: 0 KB, committed: 524 KB
[85803:0x803e34380] Large object space, used: 0 KB, available: 1480967 KB, committed: 0 KB
[85803:0x803e34380] All spaces, used: 4122 KB, available: 1483666 KB, committed: 9968KB
[85803:0x803e34380] External memory reported: 8 KB
[85803:0x803e34380] External memory global 0 KB
[85803:0x803e34380] Total time spent in GC : 5.0 ms
could allocate 1073741799
[85803:0x803e34380] Fast promotion mode: false survival rate: 7%
[85803:0x803e34380] 161 ms: Heap growing factor 1.7 based on mu=0.970, speed_ratio=0 (gc=0, mutator=21874)
[85803:0x803e34380] 161 ms: Grow: old size: 3691 KB, new limit: 13897 KB (1.1)
[85803:0x803e34380] 161 ms: Mark-sweep 4.2 (9.7) -> 3.6 (6.7) MB, 7.0 / 0.0 ms (average mu = 1.000, current mu = 1.000) external memory pressure GC in old space requested
[85803:0x803e34380] Memory allocator, used: 6896 KB, available: 1484560 KB
[85803:0x803e34380] Read-only space, used: 34 KB, available: 469 KB, committed: 512 KB
[85803:0x803e34380] New space, used: 15 KB, available: 991 KB, committed: 1024 KB
[85803:0x803e34380] Old space, used: 2828 KB, available: 735 KB, committed: 3812 KB
[85803:0x803e34380] Code space, used: 557 KB, available: 0 KB, committed: 1024KB
[85803:0x803e34380] Map space, used: 271 KB, available: 0 KB, committed: 524 KB
[85803:0x803e34380] Large object space, used: 0 KB, available: 1484039 KB, committed: 0 KB
[85803:0x803e34380] All spaces, used: 3706 KB, available: 1486236 KB, committed: 6896KB
[85803:0x803e34380] External memory reported: 1048584 KB
[85803:0x803e34380] External memory global 0 KB
[85803:0x803e34380] Total time spent in GC : 12.0 ms
could allocate
in expectsError - before
[85803:0x803e34380] Fast promotion mode: false survival rate: 0%
[85803:0x803e34380] 12874 ms: Heap growing factor 1.1 based on mu=0.970, speed_ratio=13376 (gc=627068, mutator=47)
[85803:0x803e34380] 12875 ms: Grow: old size: 3692 KB, new limit: 13898 KB (1.1)
[85803:0x803e34380] 12876 ms: Mark-sweep 3.6 (6.7) -> 3.6 (6.7) MB, 109.2 / 1.1 ms (average mu = 0.991, current mu = 0.991) external memory pressure GC in old space requested
[85803:0x803e34380] Memory allocator, used: 6896 KB, available: 1484560 KB
[85803:0x803e34380] Read-only space, used: 34 KB, available: 469 KB, committed: 512 KB
[85803:0x803e34380] New space, used: 4 KB, available: 1002 KB, committed: 1024 KB
[85803:0x803e34380] Old space, used: 2828 KB, available: 896 KB, committed: 3812 KB
[85803:0x803e34380] Code space, used: 557 KB, available: 0 KB, committed: 1024KB
[85803:0x803e34380] Map space, used: 271 KB, available: 0 KB, committed: 524 KB
[85803:0x803e34380] Large object space, used: 0 KB, available: 1484039 KB, committed: 0 KB
[85803:0x803e34380] All spaces, used: 3697 KB, available: 1486407 KB, committed: 6896KB
[85803:0x803e34380] External memory reported: 2097160 KB
[85803:0x803e34380] External memory global 0 KB
[85803:0x803e34380] Total time spent in GC : 121.1 ms
in global - before
in global - after
in global - before slice
Killed
real 0m46.301s
user 0m0.863s
sys 0m8.106s