Closed
Bug 1525415
Opened 6 years ago
Closed 2 years ago
windows/aarch64 - memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-full1-live - false == true
Categories
(Core :: Memory Allocator, defect, P5)
Tracking
()
RESOLVED
WONTFIX
People
(Reporter: intermittent-bug-filer, Unassigned)
References
Details
#[markdown(off)]
Filed by: egao [at] mozilla.com
https://treeherder.mozilla.org/logviewer.html#?job_id=226206281&repo=try
Filing issue from xpcshell suite run on win10/aarch64 hardware.
|
||
Comment 1•6 years ago
|
||
17:59:11 INFO - PID 11116 | Unable to load \\untrusted-startup-test-dll.dll; LoadLibraryW failed: 126
17:59:11 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
17:59:11 INFO - PID 11116 | DMD[8684] $DMD = '1'
17:59:11 INFO - PID 11116 | DMD[8684] Dump 1 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Dump 2 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Dump 3 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Dump 4 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] Execution measurements {
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that persist after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces: 624 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Unused stack traces: 624 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Stack trace table: 196,640 bytes (16,384 entries, 6 used)
17:59:11 INFO - PID 11116 | DMD[8684] Live block table: 24,608 bytes (512 entries, 30 used)
17:59:11 INFO - PID 11116 | DMD[8684] Dead block table: 32 bytes (0 entries, 0 used)
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that are destroyed after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 202,960 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used PCs set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Pointer ID map: 20,480 bytes
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Counts {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 7 requests
17:59:11 INFO - PID 11116 | DMD[8684] Location service cache: 0.0% hit rate, 0.2% occupancy at end
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Unknown pointer 000000000000000A
17:59:11 INFO - PID 11116 | DMD[8684] Dump 5 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] Execution measurements {
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that persist after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces: 832 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Unused stack traces: 1,456 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Stack trace table: 196,640 bytes (16,384 entries, 11 used)
17:59:11 INFO - PID 11116 | DMD[8684] Live block table: 4,128 bytes (64 entries, 30 used)
17:59:11 INFO - PID 11116 | DMD[8684] Dead block table: 32 bytes (0 entries, 0 used)
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that are destroyed after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 202,960 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used PCs set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Pointer ID map: 20,480 bytes
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Counts {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 7 requests
17:59:11 INFO - PID 11116 | DMD[8684] Location service cache: 0.0% hit rate, 0.2% occupancy at end
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Unknown pointer 000000000000000A
17:59:11 INFO - PID 11116 | DMD[8684] Dump 6 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] Execution measurements {
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that persist after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces: 832 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Unused stack traces: 2,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Stack trace table: 196,640 bytes (16,384 entries, 15 used)
17:59:11 INFO - PID 11116 | DMD[8684] Live block table: 4,128 bytes (64 entries, 27 used)
17:59:11 INFO - PID 11116 | DMD[8684] Dead block table: 32 bytes (0 entries, 0 used)
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that are destroyed after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 202,960 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used PCs set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Pointer ID map: 20,480 bytes
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Counts {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 7 requests
17:59:11 INFO - PID 11116 | DMD[8684] Location service cache: 0.0% hit rate, 0.2% occupancy at end
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Dump 7 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] Execution measurements {
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that persist after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces: 624 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Unused stack traces: 3,328 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Stack trace table: 196,640 bytes (16,384 entries, 19 used)
17:59:11 INFO - PID 11116 | DMD[8684] Live block table: 4,128 bytes (64 entries, 27 used)
17:59:11 INFO - PID 11116 | DMD[8684] Dead block table: 1,056 bytes (16 entries, 9 used)
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Data structures that are destroyed after Dump() ends {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 202,960 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used stack traces set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Used PCs set: 12,288 bytes
17:59:11 INFO - PID 11116 | DMD[8684] Pointer ID map: 20,480 bytes
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Counts {
17:59:11 INFO - PID 11116 | DMD[8684] Location service: 7 requests
17:59:11 INFO - PID 11116 | DMD[8684] Location service cache: 0.0% hit rate, 0.2% occupancy at end
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Dump 8 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - PID 11116 | DMD[8684] Dump 9 {
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the heap block list...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack trace table...
17:59:11 INFO - PID 11116 | DMD[8684] Constructing the stack frame table...
17:59:11 INFO - PID 11116 | DMD[8684] }
17:59:11 INFO - TEST-PASS | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-empty-live - true == true
17:59:11 INFO - TEST-PASS | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-empty-dark-matter - true == true
17:59:11 INFO - TEST-PASS | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-empty-cumulative - true == true
17:59:11 INFO - PID 11116 | EXPECTED:#-----------------------------------------------------------------
17:59:11 INFO - PID 11116 | EXPECTED:# dmd.py --filter-stacks-for-testing -o complete-full1-live-actual.txt complete-full1-live.json
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Invocation {
17:59:11 INFO - PID 11116 | EXPECTED: $DMD = '--mode=live --stacks=full --show-dump-stats=yes'
17:59:11 INFO - PID 11116 | EXPECTED: Mode = 'live'
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:#-----------------------------------------------------------------
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 1 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 8,192 bytes (7,169 requested / 1,023 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 67.72% of the heap (67.72% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 2 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 1,024 bytes (1,023 requested / 1 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 8.47% of the heap (76.19% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 9 blocks in heap block record 3 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 1,008 bytes (900 requested / 108 slop)
17:59:11 INFO - PID 11116 | EXPECTED: Individual block sizes: 112 x 9
17:59:11 INFO - PID 11116 | EXPECTED: 8.33% of the heap (84.52% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 6 blocks in heap block record 4 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 528 bytes (528 requested / 0 slop)
17:59:11 INFO - PID 11116 | EXPECTED: Individual block sizes: 128; 112; 96; 80; 64; 48
17:59:11 INFO - PID 11116 | EXPECTED: 4.37% of the heap (88.89% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 6 blocks in heap block record 5 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 528 bytes (528 requested / 0 slop)
17:59:11 INFO - PID 11116 | EXPECTED: Individual block sizes: 128; 112; 96; 80; 64; 48
17:59:11 INFO - PID 11116 | EXPECTED: 4.37% of the heap (93.25% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 6 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 512 bytes (512 requested / 0 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 4.23% of the heap (97.49% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 7 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 80 bytes (79 requested / 1 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 0.66% of the heap (98.15% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 8 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 80 bytes (78 requested / 2 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 0.66% of the heap (98.81% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 9 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 80 bytes (77 requested / 3 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 0.66% of the heap (99.47% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 10 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 32 bytes (30 requested / 2 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 0.26% of the heap (99.74% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 11 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 16 bytes (16 requested / 0 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 0.13% of the heap (99.87% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Live {
17:59:11 INFO - PID 11116 | EXPECTED: 1 block in heap block record 12 of 12
17:59:11 INFO - PID 11116 | EXPECTED: 16 bytes (10 requested / 6 slop)
17:59:11 INFO - PID 11116 | EXPECTED: 0.13% of the heap (100.00% cumulative)
17:59:11 INFO - PID 11116 | EXPECTED: Allocated at {
17:59:11 INFO - PID 11116 | EXPECTED: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | EXPECTED: }
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:#-----------------------------------------------------------------
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:Summary {
17:59:11 INFO - PID 11116 | EXPECTED: Total: 12,096 bytes in 30 blocks
17:59:11 INFO - PID 11116 | EXPECTED:}
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | EXPECTED:
17:59:11 INFO - PID 11116 | ACTUAL:#-----------------------------------------------------------------
17:59:11 INFO - PID 11116 | ACTUAL:# dmd.py --filter-stacks-for-testing -o complete-full1-live-actual.txt complete-full1-live.json
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:Invocation {
17:59:11 INFO - PID 11116 | ACTUAL: $DMD = '--mode=live --stacks=full --show-dump-stats=yes'
17:59:11 INFO - PID 11116 | ACTUAL: Mode = 'live'
17:59:11 INFO - PID 11116 | ACTUAL:}
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:#-----------------------------------------------------------------
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:Live {
17:59:11 INFO - PID 11116 | ACTUAL: 18 blocks in heap block record 1 of 3
17:59:11 INFO - PID 11116 | ACTUAL: 11,040 bytes (9,894 requested / 1,146 slop)
17:59:11 INFO - PID 11116 | ACTUAL: Individual block sizes: 8,192; 1,024; 512; 112 x 9; 80 x 3; 32; 16 x 2
17:59:11 INFO - PID 11116 | ACTUAL: 91.27% of the heap (91.27% cumulative)
17:59:11 INFO - PID 11116 | ACTUAL: Allocated at {
17:59:11 INFO - PID 11116 | ACTUAL: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | ACTUAL: }
17:59:11 INFO - PID 11116 | ACTUAL:}
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:Live {
17:59:11 INFO - PID 11116 | ACTUAL: 6 blocks in heap block record 2 of 3
17:59:11 INFO - PID 11116 | ACTUAL: 528 bytes (528 requested / 0 slop)
17:59:11 INFO - PID 11116 | ACTUAL: Individual block sizes: 128; 112; 96; 80; 64; 48
17:59:11 INFO - PID 11116 | ACTUAL: 4.37% of the heap (95.63% cumulative)
17:59:11 INFO - PID 11116 | ACTUAL: Allocated at {
17:59:11 INFO - PID 11116 | ACTUAL: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | ACTUAL: }
17:59:11 INFO - PID 11116 | ACTUAL:}
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:Live {
17:59:11 INFO - PID 11116 | ACTUAL: 6 blocks in heap block record 3 of 3
17:59:11 INFO - PID 11116 | ACTUAL: 528 bytes (528 requested / 0 slop)
17:59:11 INFO - PID 11116 | ACTUAL: Individual block sizes: 128; 112; 96; 80; 64; 48
17:59:11 INFO - PID 11116 | ACTUAL: 4.37% of the heap (100.00% cumulative)
17:59:11 INFO - PID 11116 | ACTUAL: Allocated at {
17:59:11 INFO - PID 11116 | ACTUAL: #01: ... DMD.cpp ...
17:59:11 INFO - PID 11116 | ACTUAL: }
17:59:11 INFO - PID 11116 | ACTUAL:}
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:#-----------------------------------------------------------------
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:Summary {
17:59:11 INFO - PID 11116 | ACTUAL: Total: 12,096 bytes in 30 blocks
17:59:11 INFO - PID 11116 | ACTUAL:}
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 INFO - PID 11116 | ACTUAL:
17:59:11 WARNING - TEST-UNEXPECTED-FAIL | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-full1-live - false == true
17:59:11 INFO - C:/tasks/task_1549388868/build/tests/xpcshell/tests/memory/replace/dmd/test/test_dmd.js:test:110
17:59:11 INFO - C:/tasks/task_1549388868/build/tests/xpcshell/tests/memory/replace/dmd/test/test_dmd.js:test2:143
17:59:11 INFO - C:/tasks/task_1549388868/build/tests/xpcshell/tests/memory/replace/dmd/test/test_dmd.js:run_test:153
17:59:11 INFO - C:\tasks\task_1549388868\build\tests\xpcshell\head.js:_execute_test:521
17:59:11 INFO - -e:null:1
17:59:11 INFO - exiting test
|
||
Comment 2•6 years ago
|
||
:erahm, any thoughts on how to proceed with this bug for arm64? If there are bugs for work in progress I would like to link it here so we can depend on other fixes.
Flags: needinfo?(erahm)
Keywords: intermittent-failure
Summary: Intermittent memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-full1-live - false == true → windows/aarch64 - memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-full1-live - false == true
|
||
Comment 3•6 years ago
|
||
It looks like this is the one where we're expecting 12 blocks but only get 3. Nick, do you have any ideas here?
Flags: needinfo?(erahm) → needinfo?(n.nethercote)
|
||
Comment 4•6 years ago
|
||
We are getting only 3 records for the 30 allocations, instead of the expected 12. Which means that something is wrong with the stack traces -- allocations that should have distinct stack traces do not.
The test does some post-filtering of the obtained stack traces to remove uninteresting differences: https://searchfox.org/mozilla-central/source/memory/replace/dmd/dmd.py#336-350
So we can't tell the exact problem just from the above output. The way to investigate this is to run the test with --filter-stacks-for-testing removed from dmd.py and see what the stack traces look like on aarch64 vs other platforms. It looks like the stack traces have the right filename (because the filtering leaves behind "... DMD.cpp ...") but perhaps the line numbers in the unfiltered records are missing or incorrect.
Flags: needinfo?(n.nethercote)
|
|
||
Comment 5•6 years ago
|
||
:egao, when you get some cycles, could you run this locally with the changes :njn suggested?
Flags: needinfo?(egao)
|
||
Comment 6•6 years ago
|
||
I wonder if this could be related to bug 1515229.
|
|
||
Comment 7•6 years ago
|
||
(In reply to Joel Maher ( :jmaher ) (UTC-4) from comment #5)
:egao, when you get some cycles, could you run this locally with the changes :njn suggested?
I've disabled the line in dmd.py line 195 where --filter-stacks-for-testing is added to the ArgumentParser object.
Treeherder: https://treeherder.mozilla.org/#/jobs?repo=try&revision=f964fd74170aaa9de4ac74814dafd8b2d5d8541b
|
|
||
Comment 8•6 years ago
|
||
I found egao's push with the job:
https://treeherder.mozilla.org/#/jobs?repo=try&revision=3b54f06f5ca6ad942d26ecac504e0ca3edc8c623
not sure how to count records for allocations or where to look for stack traces in the log:
https://taskcluster-artifacts.net/ParrEwV8TfSkkqFVVCYpVg/0/public/logs/live_backing.log
:erahm, :njn - maybe you could take a look at that run and suggest any next steps?
|
|
||
Comment 9•6 years ago
|
||
The relevant output is here:
03:36:05 INFO - PID 4352 | EXPECTED:#-----------------------------------------------------------------
03:36:05 INFO - PID 4352 | EXPECTED:# dmd.py --filter-stacks-for-testing -o complete-empty-live-actual.txt complete-empty-live.json
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | EXPECTED:Invocation {
03:36:05 INFO - PID 4352 | EXPECTED: $DMD = '--mode=live --stacks=full'
03:36:05 INFO - PID 4352 | EXPECTED: Mode = 'live'
03:36:05 INFO - PID 4352 | EXPECTED:}
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | EXPECTED:#-----------------------------------------------------------------
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | EXPECTED:# no live heap blocks
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | EXPECTED:#-----------------------------------------------------------------
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | EXPECTED:Summary {
03:36:05 INFO - PID 4352 | EXPECTED: Total: 0 bytes in 0 blocks
03:36:05 INFO - PID 4352 | EXPECTED:}
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | EXPECTED:
03:36:05 INFO - PID 4352 | ACTUAL:#-----------------------------------------------------------------
03:36:05 INFO - PID 4352 | ACTUAL:# dmd.py -o complete-empty-live-actual.txt complete-empty-live.json
03:36:05 INFO - PID 4352 | ACTUAL:
03:36:05 INFO - PID 4352 | ACTUAL:Invocation {
03:36:05 INFO - PID 4352 | ACTUAL: $DMD = '--mode=live --stacks=full'
03:36:05 INFO - PID 4352 | ACTUAL: Mode = 'live'
03:36:05 INFO - PID 4352 | ACTUAL:}
03:36:05 INFO - PID 4352 | ACTUAL:
03:36:05 INFO - PID 4352 | ACTUAL:#-----------------------------------------------------------------
03:36:05 INFO - PID 4352 | ACTUAL:
03:36:05 INFO - PID 4352 | ACTUAL:# no live heap blocks
03:36:05 INFO - PID 4352 | ACTUAL:
03:36:05 INFO - PID 4352 | ACTUAL:#-----------------------------------------------------------------
03:36:05 INFO - PID 4352 | ACTUAL:
03:36:05 INFO - PID 4352 | ACTUAL:Summary {
03:36:05 INFO - PID 4352 | ACTUAL: Total: 0 bytes in 0 blocks
03:36:05 INFO - PID 4352 | ACTUAL:}
03:36:05 INFO - PID 4352 | ACTUAL:
03:36:05 INFO - PID 4352 | ACTUAL:
It's a trivial fail on line 2 caused by the fact that the --filter-stacks-for-testing argument shows up in the output. It'll need to be removed from all the expected output files.
| Comment hidden (Intermittent Failures Robot) |
|
|
||
Comment 11•6 years ago
|
||
:egao, you should be able to modify the test and related files:
https://searchfox.org/mozilla-central/search?q=filter-stacks-for-testing&case=false®exp=false&path=
|
|
||
Comment 12•6 years ago
•
|
||
Updated push with the changes: https://treeherder.mozilla.org/#/jobs?repo=try&selectedJob=227718114&revision=fe5461275fefac5c0b6f2dca0fa1e33ff05a76c7
Disabled all --filter-for-stacks-for-testing argument in the expected outcomes.
Disabled --filter-for-stacks-for-testing argument in test_dmd.js.
Flags: needinfo?(egao)
|
|
||
Comment 13•6 years ago
•
|
||
23:19:13 WARNING - TEST-UNEXPECTED-FAIL | memory/replace/dmd/test/test_dmd.js | xpcshell return code: 0
23:19:13 INFO - TEST-INFO took 1509ms
23:19:13 INFO - >>>>>>>
23:19:13 INFO - PID 9976 | Unable to load \\untrusted-startup-test-dll.dll; LoadLibraryW failed: 126
23:19:13 INFO - (xpcshell/head.js) | test MAIN run_test pending (1)
23:19:13 INFO - PID 9976 | DMD[1864] $DMD = '1'
23:19:13 INFO - PID 9976 | DMD[1864] Dump 1 {
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:13 INFO - PID 9976 | DMD[1864] }
23:19:13 INFO - PID 9976 | DMD[1864] Dump 2 {
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:13 INFO - PID 9976 | DMD[1864] }
23:19:13 INFO - PID 9976 | DMD[1864] Dump 3 {
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:13 INFO - PID 9976 | DMD[1864] }
23:19:13 INFO - PID 9976 | DMD[1864] Dump 4 {
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:13 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:13 INFO - PID 9976 | DMD[1864] Execution measurements {
23:19:13 INFO - PID 9976 | DMD[1864] Data structures that persist after Dump() ends {
23:19:13 INFO - PID 9976 | DMD[1864] Used stack traces: 624 bytes
23:19:13 INFO - PID 9976 | DMD[1864] Unused stack traces: 624 bytes
23:19:13 INFO - PID 9976 | DMD[1864] Stack trace table: 196,640 bytes (16,384 entries, 6 used)
23:19:13 INFO - PID 9976 | DMD[1864] Live block table: 24,608 bytes (512 entries, 30 used)
23:19:13 INFO - PID 9976 | DMD[1864] Dead block table: 32 bytes (0 entries, 0 used)
23:19:13 INFO - PID 9976 | DMD[1864] }
23:19:13 INFO - PID 9976 | DMD[1864] Data structures that are destroyed after Dump() ends {
23:19:13 INFO - PID 9976 | DMD[1864] Location service: 202,960 bytes
23:19:13 INFO - PID 9976 | DMD[1864] Used stack traces set: 12,288 bytes
23:19:13 INFO - PID 9976 | DMD[1864] Used PCs set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Pointer ID map: 20,480 bytes
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Counts {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 7 requests
23:19:14 INFO - PID 9976 | DMD[1864] Location service cache: 0.0% hit rate, 0.2% occupancy at end
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Unknown pointer 000000000000000A
23:19:14 INFO - PID 9976 | DMD[1864] Dump 5 {
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:14 INFO - PID 9976 | DMD[1864] Execution measurements {
23:19:14 INFO - PID 9976 | DMD[1864] Data structures that persist after Dump() ends {
23:19:14 INFO - PID 9976 | DMD[1864] Used stack traces: 832 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Unused stack traces: 1,456 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Stack trace table: 196,640 bytes (16,384 entries, 11 used)
23:19:14 INFO - PID 9976 | DMD[1864] Live block table: 4,128 bytes (64 entries, 30 used)
23:19:14 INFO - PID 9976 | DMD[1864] Dead block table: 32 bytes (0 entries, 0 used)
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Data structures that are destroyed after Dump() ends {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 202,960 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Used stack traces set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Used PCs set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Pointer ID map: 20,480 bytes
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Counts {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 7 requests
23:19:14 INFO - PID 9976 | DMD[1864] Location service cache: 0.0% hit rate, 0.2% occupancy at end
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Unknown pointer 000000000000000A
23:19:14 INFO - PID 9976 | DMD[1864] Dump 6 {
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:14 INFO - PID 9976 | DMD[1864] Execution measurements {
23:19:14 INFO - PID 9976 | DMD[1864] Data structures that persist after Dump() ends {
23:19:14 INFO - PID 9976 | DMD[1864] Used stack traces: 832 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Unused stack traces: 2,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Stack trace table: 196,640 bytes (16,384 entries, 15 used)
23:19:14 INFO - PID 9976 | DMD[1864] Live block table: 4,128 bytes (64 entries, 27 used)
23:19:14 INFO - PID 9976 | DMD[1864] Dead block table: 32 bytes (0 entries, 0 used)
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Data structures that are destroyed after Dump() ends {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 202,960 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Used stack traces set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Used PCs set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Pointer ID map: 20,480 bytes
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Counts {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 7 requests
23:19:14 INFO - PID 9976 | DMD[1864] Location service cache: 0.0% hit rate, 0.2% occupancy at end
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Dump 7 {
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:14 INFO - PID 9976 | DMD[1864] Execution measurements {
23:19:14 INFO - PID 9976 | DMD[1864] Data structures that persist after Dump() ends {
23:19:14 INFO - PID 9976 | DMD[1864] Used stack traces: 624 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Unused stack traces: 3,328 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Stack trace table: 196,640 bytes (16,384 entries, 19 used)
23:19:14 INFO - PID 9976 | DMD[1864] Live block table: 4,128 bytes (64 entries, 27 used)
23:19:14 INFO - PID 9976 | DMD[1864] Dead block table: 1,056 bytes (16 entries, 9 used)
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Data structures that are destroyed after Dump() ends {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 202,960 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Used stack traces set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Used PCs set: 12,288 bytes
23:19:14 INFO - PID 9976 | DMD[1864] Pointer ID map: 20,480 bytes
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Counts {
23:19:14 INFO - PID 9976 | DMD[1864] Location service: 7 requests
23:19:14 INFO - PID 9976 | DMD[1864] Location service cache: 0.0% hit rate, 0.2% occupancy at end
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Dump 8 {
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - PID 9976 | DMD[1864] Dump 9 {
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the heap block list...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack trace table...
23:19:14 INFO - PID 9976 | DMD[1864] Constructing the stack frame table...
23:19:14 INFO - PID 9976 | DMD[1864] }
23:19:14 INFO - TEST-PASS | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-empty-live - true == true
23:19:14 INFO - TEST-PASS | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-empty-dark-matter - true == true
23:19:14 INFO - TEST-PASS | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-empty-cumulative - true == true
23:19:14 INFO - PID 9976 | Traceback (most recent call last):
23:19:14 INFO - PID 9976 | File "C:\\tasks\\task_1549926480\\build\\application\\firefox\\dmd.py", line 916, in <module>
23:19:14 INFO - PID 9976 | main()
23:19:14 INFO - PID 9976 | File "C:\\tasks\\task_1549926480\\build\\application\\firefox\\dmd.py", line 908, in main
23:19:14 INFO - PID 9976 | digest = getDigestFromFile(args, args.input_file)
23:19:14 INFO - PID 9976 | File "C:\\tasks\\task_1549926480\\build\\application\\firefox\\dmd.py", line 447, in getDigestFromFile
23:19:14 INFO - PID 9976 | allocatedAtTraceKey)
23:19:14 INFO - PID 9976 | File "C:\\tasks\\task_1549926480\\build\\application\\firefox\\dmd.py", line 336, in buildTraceDescription
23:19:14 INFO - PID 9976 | if args.filter_stacks_for_testing:
23:19:14 INFO - PID 9976 | AttributeError: 'Namespace' object has no attribute 'filter_stacks_for_testing'
23:19:14 INFO - PID 9976 | EXPECTED:#-----------------------------------------------------------------
23:19:14 INFO - PID 9976 | EXPECTED:# dmd.py -o complete-full1-live-actual.txt complete-full1-live.json
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Invocation {
23:19:14 INFO - PID 9976 | EXPECTED: $DMD = '--mode=live --stacks=full --show-dump-stats=yes'
23:19:14 INFO - PID 9976 | EXPECTED: Mode = 'live'
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:#-----------------------------------------------------------------
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 1 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 8,192 bytes (7,169 requested / 1,023 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 67.72% of the heap (67.72% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 2 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 1,024 bytes (1,023 requested / 1 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 8.47% of the heap (76.19% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 9 blocks in heap block record 3 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 1,008 bytes (900 requested / 108 slop)
23:19:14 INFO - PID 9976 | EXPECTED: Individual block sizes: 112 x 9
23:19:14 INFO - PID 9976 | EXPECTED: 8.33% of the heap (84.52% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 6 blocks in heap block record 4 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 528 bytes (528 requested / 0 slop)
23:19:14 INFO - PID 9976 | EXPECTED: Individual block sizes: 128; 112; 96; 80; 64; 48
23:19:14 INFO - PID 9976 | EXPECTED: 4.37% of the heap (88.89% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 6 blocks in heap block record 5 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 528 bytes (528 requested / 0 slop)
23:19:14 INFO - PID 9976 | EXPECTED: Individual block sizes: 128; 112; 96; 80; 64; 48
23:19:14 INFO - PID 9976 | EXPECTED: 4.37% of the heap (93.25% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 6 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 512 bytes (512 requested / 0 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 4.23% of the heap (97.49% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 7 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 80 bytes (79 requested / 1 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 0.66% of the heap (98.15% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 8 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 80 bytes (78 requested / 2 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 0.66% of the heap (98.81% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 9 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 80 bytes (77 requested / 3 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 0.66% of the heap (99.47% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 10 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 32 bytes (30 requested / 2 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 0.26% of the heap (99.74% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 11 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 16 bytes (16 requested / 0 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 0.13% of the heap (99.87% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Live {
23:19:14 INFO - PID 9976 | EXPECTED: 1 block in heap block record 12 of 12
23:19:14 INFO - PID 9976 | EXPECTED: 16 bytes (10 requested / 6 slop)
23:19:14 INFO - PID 9976 | EXPECTED: 0.13% of the heap (100.00% cumulative)
23:19:14 INFO - PID 9976 | EXPECTED: Allocated at {
23:19:14 INFO - PID 9976 | EXPECTED: #01: ... DMD.cpp ...
23:19:14 INFO - PID 9976 | EXPECTED: }
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:#-----------------------------------------------------------------
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:Summary {
23:19:14 INFO - PID 9976 | EXPECTED: Total: 12,096 bytes in 30 blocks
23:19:14 INFO - PID 9976 | EXPECTED:}
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | EXPECTED:
23:19:14 INFO - PID 9976 | ACTUAL:
23:19:14 WARNING - TEST-UNEXPECTED-FAIL | memory/replace/dmd/test/test_dmd.js | test - [test : 110] complete-full1-live - false == true
23:19:14 INFO - C:/tasks/task_1549926480/build/tests/xpcshell/tests/memory/replace/dmd/test/test_dmd.js:test:110
23:19:14 INFO - C:/tasks/task_1549926480/build/tests/xpcshell/tests/memory/replace/dmd/test/test_dmd.js:test2:143
23:19:14 INFO - C:/tasks/task_1549926480/build/tests/xpcshell/tests/memory/replace/dmd/test/test_dmd.js:run_test:153
23:19:14 INFO - C:\tasks\task_1549926480\build\tests\xpcshell\head.js:_execute_test:521
23:19:14 INFO - -e:null:1
23:19:14 INFO - exiting test
23:19:14 INFO - <<<<<<<
|
|
||
Comment 14•6 years ago
|
||
:njn, I have re-ran the affected test with the changes made, and the output of the log file has changed to contain data in the EXPECTED sections.
Please let me know if this is what you expect, and whether you need additional data.
Flags: needinfo?(n.nethercote)
|
|
||
Comment 15•6 years ago
•
|
||
As of this try push it appears that this test is either no longer running or not failing.
I'm willing to close this bug as resolved - fixed, unless you would like to still look into this.
Edit: this test began failing again from subsequent try pushes, so this bug will likely have to remain open.
|
|
||
Comment 16•6 years ago
|
||
Test disabled for windows10-aarch64 in https://phabricator.services.mozilla.com/D23956 due to consistent failure.
|
|
||
Updated•6 years ago
|
|
|
||
Updated•6 years ago
|
OS: Unspecified → Windows
Hardware: Unspecified → ARM64
|
|
||
Updated•6 years ago
|
Flags: needinfo?(n.nethercote)
|
|
||
Comment 17•2 years ago
|
||
closing out due to the fact that we don't run xpcshell tests on win/aarch64.
Status: NEW → RESOLVED
Closed: 2 years ago
Resolution: --- → WONTFIX
You need to log in
before you can comment on or make changes to this bug.
Description
•