1841275 - Intermittent ==1618==ERROR: AddressSanitizer: out of memory: failed to allocate 0x1000 (4096) bytes of ReadFileToBuffer (error code: 12)

Status: RESOLVED INCOMPLETE

(Core :: Layout: Tables, defect, P5)

Description

[Treeherder Bug Filer]

Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=421192368&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/dB6OofoKRBqZV89tBsripw/runs/0/artifacts/public/logs/live_backing.log
Reftest URL: https://hg.mozilla.org/mozilla-central/raw-file/tip/layout/tools/reftest/reftest-analyzer.xhtml#logurl=https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/dB6OofoKRBqZV89tBsripw/runs/0/artifacts/public/logs/live_backing.log&only_show_unexpected=1

---

[task 2023-06-30T11:03:07.308Z] 11:03:07     INFO - REFTEST TEST-START | layout/tables/crashtests/750147.html
[task 2023-06-30T11:03:07.386Z] 11:03:07     INFO - REFTEST INFO | SET PREFERENCE pref(font.size.inflation.minTwips,120)
[task 2023-06-30T11:03:07.388Z] 11:03:07     INFO - REFTEST TEST-LOAD | file:///builds/worker/workspace/build/tests/reftest/tests/layout/tables/crashtests/750147.html | 3781 / 3988 (94%)
[task 2023-06-30T11:04:57.752Z] 11:04:57     INFO - out of memory: 0x0000000000001000 bytes requested
[task 2023-06-30T11:04:57.755Z] 11:04:57     INFO - AddressSanitizer:DEADLYSIGNAL
[task 2023-06-30T11:04:57.755Z] 11:04:57     INFO - =================================================================
[task 2023-06-30T11:04:57.755Z] 11:04:57    ERROR - ==1618==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x5648b79c1362 bp 0x7ffd61c45b70 sp 0x7ffd61c45b50 T0)
[task 2023-06-30T11:04:57.755Z] 11:04:57     INFO - ==1618==The signal is caused by a WRITE memory access.
[task 2023-06-30T11:04:57.755Z] 11:04:57     INFO - ==1618==Hint: address points to the zero page.
[task 2023-06-30T11:04:57.755Z] 11:04:57    ERROR - ==1618==ERROR: AddressSanitizer: out of memory: failed to allocate 0x1000 (4096) bytes of ReadFileToBuffer (error code: 12)
[task 2023-06-30T11:04:57.755Z] 11:04:57     INFO - ERROR: Failed to mmap
[task 2023-06-30T11:04:58.242Z] 11:04:58    ERROR - A content process crashed and MOZ_CRASHREPORTER_SHUTDOWN is set, shutting down
[task 2023-06-30T11:04:58.955Z] 11:04:58     INFO - Crash Annotation GraphicsCriticalError: |[0][GFX1-]: Attempting to allocate a texture of size 10000x10000 above the limit, trimming (t=128.915) |[526]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.482) |[527]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.487) |[528]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.487) |[529]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.5) |[530]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.5) |[531]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.504) |[532]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.504) |[533]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.517) |[534]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.518) |[535]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.529) |[536]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.529) |[537][GFX1-]: wr_renderer_render: OutOfMemory (t=1258.12) |[523]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.442) |[524]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.442) |[525]CP+[GFX1-]: Failed to allocate a surface due to invalid size (CDT) Size(53687092,96) (t=947.481) [GFX1-]: wr_renderer_render: OutOfMemory
[task 2023-06-30T11:11:33.920Z] 11:11:32    ERROR - REFTEST ERROR | layout/tables/crashtests/750147.html | application timed out after 370 seconds with no output
[task 2023-06-30T11:11:36.516Z] 11:11:36  WARNING - REFTEST WARNING | Force-terminating active process(es).
[task 2023-06-30T11:11:36.516Z] 11:11:36     INFO - REFTEST TEST-INFO | started process screentopng
[task 2023-06-30T11:11:36.517Z] 11:11:36     INFO - REFTEST INFO | Failed to start /builds/worker/workspace/build/tests/bin/screentopng for screenshot: Cannot allocate memory
[task 2023-06-30T11:11:36.517Z] 11:11:36     INFO - REFTEST INFO | Can't trigger Breakpad, just killing process
[task 2023-06-30T11:11:36.801Z] 11:11:36    ERROR - TEST-UNEXPECTED-FAIL | layout/tables/crashtests/750147.html | application terminated with exit code -15
[task 2023-06-30T11:11:36.826Z] 11:11:36     INFO - REFTEST INFO | Process mode: e10s
[task 2023-06-30T11:11:36.866Z] 11:11:36     INFO - Return code: 241
[task 2023-06-30T11:11:36.866Z] 11:11:36    ERROR - No suite end message was emitted by this harness.
[task 2023-06-30T11:11:36.866Z] 11:11:36     INFO - TinderboxPrint: reftest-crashtest<br/>7546/0/0
[task 2023-06-30T11:11:36.866Z] 11:11:36  WARNING - setting return code to 2
[task 2023-06-30T11:11:36.867Z] 11:11:36     INFO - The reftest suite: crashtest ran with return status: FAILURE
[task 2023-06-30T11:11:36.867Z] 11:11:36     INFO - Running post-action listener: _package_coverage_data
[task 2023-06-30T11:11:36.867Z] 11:11:36     INFO - Running post-action listener: _resource_record_post_action
[task 2023-06-30T11:11:36.867Z] 11:11:36     INFO - Running post-action listener: process_java_coverage_data
[task 2023-06-30T11:11:36.867Z] 11:11:36     INFO - [mozharness: 2023-06-30 11:11:36.867750Z] Finished run-tests step (success)
[task 2023-06-30T11:11:36.867Z] 11:11:36     INFO - [mozharness: 2023-06-30 11:11:36.867907Z] Running uninstall step.
[task 2023-06-30T11:11:36.868Z] 11:11:36     INFO - Running pre-action listener: _resource_record_pre_action
[task 2023-06-30T11:11:36.868Z] 11:11:36     INFO - Running main action method: uninstall
[task 2023-06-30T11:11:36.868Z] 11:11:36     INFO - Skipping uninstall for non-MSIX test
[task 2023-06-30T11:11:36.868Z] 11:11:36     INFO - Running post-action listener: _resource_record_post_action
[task 2023-06-30T11:11:36.868Z] 11:11:36     INFO - [mozharness: 2023-06-30 11:11:36.868341Z] Finished uninstall step (success)
[task 2023-06-30T11:11:36.868Z] 11:11:36     INFO - Running post-run listener: _resource_record_post_run
[task 2023-06-30T11:11:37.064Z] 11:11:37     INFO - Validating Perfherder data against /builds/worker/workspace/mozharness/external_tools/performance-artifact-schema.json
[task 2023-06-30T11:11:37.067Z] 11:11:37     INFO - PERFHERDER_DATA: {"framework": {"name": "job_resource_usage"}, "suites": [{"name": "reftest.crashtest.overall", "extraOptions": ["e10s", "taskcluster-projects/887720501152/machineTypes/n2-standard-2"], "subtests": [{"name": "cpu_percent", "value": 74.722100567721}, {"name": "io_write_bytes", "value": 4431740928}, {"name": "io.read_bytes", "value": 756890558464}, {"name": "io_write_time", "value": 2244484}, {"name": "io_read_time", "value": 22632456}]}, {"name": "reftest.crashtest.start-pulseaudio", "subtests": [{"name": "time", "value": 0.03074026107788086}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.crashtest.install", "subtests": [{"name": "time", "value": 65.85676050186157}, {"name": "cpu_percent", "value": 50.493750000000006}]}, {"name": "reftest.crashtest.stage-files", "subtests": [{"name": "time", "value": 0.002135753631591797}, {"name": "cpu_percent", "value": 0}]}, {"name": "reftest.crashtest.run-tests", "subtests": [{"name": "time", "value": 1656.4060635566711}, {"name": "cpu_percent", "value": 76.09044558697514}]}, {"name": "reftest.crashtest.uninstall", "subtests": [{"name": "time", "value": 0.0002391338348388672}, {"name": "cpu_percent", "value": 0}]}]}
[task 2023-06-30T11:11:37.067Z] 11:11:37     INFO - Total resource usage - Wall time: 1722s; CPU: Can't collect data; Read bytes: 756890558464; Write bytes: 4431740928; Read time: 22632456; Write time: 2244484
[task 2023-06-30T11:11:37.067Z] 11:11:37     INFO - TinderboxPrint: I/O read bytes / time<br/>756,890,558,464 / 22,632,456
[task 2023-06-30T11:11:37.068Z] 11:11:37     INFO - TinderboxPrint: I/O write bytes / time<br/>4,431,740,928 / 2,244,484
[task 2023-06-30T11:11:37.068Z] 11:11:37     INFO - TinderboxPrint: CPU idle<br/>604.2 (17.7%)
[task 2023-06-30T11:11:37.068Z] 11:11:37     INFO - TinderboxPrint: CPU iowait<br/>318.0 (9.3%)
[task 2023-06-30T11:11:37.068Z] 11:11:37     INFO - TinderboxPrint: CPU system<br/>868.5 (25.5%)
[task 2023-06-30T11:11:37.068Z] 11:11:37     INFO - TinderboxPrint: CPU user<br/>1,611.9 (47.3%)
[task 2023-06-30T11:11:37.068Z] 11:11:37     INFO - TinderboxPrint: Swap in / out<br/>0 / 0
[task 2023-06-30T11:11:37.069Z] 11:11:37     INFO - start-pulseaudio - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-06-30T11:11:37.070Z] 11:11:37     INFO - install - Wall time: 66s; CPU: 50%; Read bytes: 229376; Write bytes: 3736264704; Read time: 360; Write time: 2150412
[task 2023-06-30T11:11:37.070Z] 11:11:37     INFO - stage-files - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-06-30T11:11:37.076Z] 11:11:37     INFO - run-tests - Wall time: 1656s; CPU: 76%; Read bytes: 756890042368; Write bytes: 695476224; Read time: 22632088; Write time: 94072
[task 2023-06-30T11:11:37.077Z] 11:11:37     INFO - uninstall - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0
[task 2023-06-30T11:11:37.209Z] 11:11:37  WARNING - returning nonzero exit status 2
[task 2023-06-30T11:11:37.259Z] cleanup
[task 2023-06-30T11:11:37.259Z] + cleanup
[task 2023-06-30T11:11:37.259Z] + local rv=2
[task 2023-06-30T11:11:37.259Z] + [[ -s /builds/worker/.xsession-errors ]]
[task 2023-06-30T11:11:37.259Z] + cp /builds/worker/.xsession-errors /builds/worker/artifacts/public/xsession-errors.log
[task 2023-06-30T11:11:37.273Z] + '[' ']'
[task 2023-06-30T11:11:37.273Z] + true
[task 2023-06-30T11:11:37.273Z] + cleanup_xvfb
[task 2023-06-30T11:11:37.273Z] ++ pidof Xvfb
[task 2023-06-30T11:11:37.281Z] + local xvfb_pid=49
[task 2023-06-30T11:11:37.281Z] + local vnc=false
[task 2023-06-30T11:11:37.281Z] + local interactive=false
[task 2023-06-30T11:11:37.281Z] + '[' -n 49 ']'
[task 2023-06-30T11:11:37.281Z] + [[ false == false ]]
[task 2023-06-30T11:11:37.281Z] + [[ false == false ]]
[task 2023-06-30T11:11:37.281Z] + kill 49
[task 2023-06-30T11:11:37.281Z] + screen -XS xvfb quit
[task 2023-06-30T11:11:37.363Z] + exit 2
[taskcluster 2023-06-30 11:11:41.193Z] === Task Finished ===
[taskcluster 2023-06-30 11:11:51.640Z] Unsuccessful task run with exit code: 2 completed in 1951.163 seconds

Comment 1

[Intermittent Failures Robot]

3 failures in 3594 pushes (0.001 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 3

Platform and build breakdown:

• linux1804-64-asan-qr: 3
  • opt: 3

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1841275&startday=2023-06-26&endday=2023-07-02&tree=all

Comment 2

[Intermittent Failures Robot]

1 failures in 2956 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1841275&startday=2023-07-03&endday=2023-07-09&tree=all

Comment 3

[Intermittent Failures Robot]

1 failures in 3276 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1841275&startday=2023-07-31&endday=2023-08-06&tree=all

Comment 4

[Intermittent Failures Robot]

1 failures in 3341 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1841275&startday=2023-08-07&endday=2023-08-13&tree=all

Comment 5

[Intermittent Failures Robot]

1 failures in 3337 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1841275&startday=2023-09-11&endday=2023-09-17&tree=all

Comment 6

[Intermittent Failures Robot]

1 failures in 3356 pushes (0.0 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• mozilla-central: 1

Platform and build breakdown:

• linux1804-64-asan-qr: 1
  • opt: 1

For more details, see:
https://treeherder.mozilla.org/intermittent-failures/bugdetails?bug=1841275&startday=2023-10-30&endday=2023-11-05&tree=all

Comment 7

[BugBot [:suhaib / :marco/ :calixte]]

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup
For more information, please visit BugBot documentation.