Closed Bug 1752844 Opened 3 years ago Closed 3 years ago

Intermittent SUMMARY: ThreadSanitizer: data race (/builds/worker/workspace/build/application/firefox/libmozsqlite3.so+0x3a262)

Categories

(Core :: Storage: IndexedDB, defect, P5)

defect

Tracking

()

RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Blocks 1 open bug)

Details

(Keywords: csectype-race, intermittent-failure)

Filed by: imoraru [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer?job_id=366175221&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/YrERXKtaR0OL-BHTh-2cTA/runs/0/artifacts/public/logs/live_backing.log


[task 2022-01-31T14:20:31.884Z] 14:20:31     INFO - TEST-START | browser/components/urlbar/tests/browser/browser_remove_match.js
[task 2022-01-31T14:20:32.632Z] 14:20:32     INFO - GECKO(1588) | ==================
[task 2022-01-31T14:20:32.634Z] 14:20:32     INFO - GECKO(1588) | WARNING: ThreadSanitizer: data race (pid=1588)
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |   Write of size 8 at 0x7b4000b4d158 by thread T42:
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |     #0 <null> <null> (libmozsqlite3.so+0x3a262)
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |     #1 <null> <null> (libmozsqlite3.so+0x3aab0)
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |     #2 <null> <null> (libxul.so+0x1fee1b4)
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |     #3 <null> <null> (libxul.so+0x200a266)
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |     #4 <null> <null> (libxul.so+0x4ab89f7)
[task 2022-01-31T14:20:32.637Z] 14:20:32     INFO - GECKO(1588) |     #5 <null> <null> (libxul.so+0x4ab7b3d)
[task 2022-01-31T14:20:32.638Z] 14:20:32     INFO - GECKO(1588) |     #6 <null> <null> (libxul.so+0x4ab6edd)
[task 2022-01-31T14:20:32.640Z] 14:20:32     INFO - GECKO(1588) |     #7 <null> <null> (libxul.so+0x4ab61c1)
[task 2022-01-31T14:20:32.640Z] 14:20:32     INFO - GECKO(1588) |     #8 <null> <null> (libxul.so+0x4ab562e)
[task 2022-01-31T14:20:32.640Z] 14:20:32     INFO - GECKO(1588) |     #9 <null> <null> (libxul.so+0x4ab51fe)
[task 2022-01-31T14:20:32.640Z] 14:20:32     INFO - GECKO(1588) |     #10 <null> <null> (libxul.so+0xfa3403)
[task 2022-01-31T14:20:32.640Z] 14:20:32     INFO - GECKO(1588) |     #11 <null> <null> (libxul.so+0xfa9e22)
[task 2022-01-31T14:20:32.642Z] 14:20:32     INFO - GECKO(1588) |     #12 <null> <null> (libxul.so+0x4aafdfa)
[task 2022-01-31T14:20:32.642Z] 14:20:32     INFO - GECKO(1588) |     #13 <null> <null> (libxul.so+0xfa3403)
[task 2022-01-31T14:20:32.643Z] 14:20:32     INFO - GECKO(1588) |     #14 <null> <null> (libxul.so+0xfa9e22)
[task 2022-01-31T14:20:32.643Z] 14:20:32     INFO - GECKO(1588) |     #15 <null> <null> (libxul.so+0x191de1e)
[task 2022-01-31T14:20:32.644Z] 14:20:32     INFO - GECKO(1588) |     #16 <null> <null> (libxul.so+0x189b53c)
[task 2022-01-31T14:20:32.644Z] 14:20:32     INFO - GECKO(1588) |     #17 <null> <null> (libxul.so+0xf9f4e3)
[task 2022-01-31T14:20:32.648Z] 14:20:32     INFO - GECKO(1588) |     #18 <null> <null> (libnspr4.so+0x44fbd)
[task 2022-01-31T14:20:32.648Z] 14:20:32     INFO - GECKO(1588) |     #19 <null> <null> (firefox+0x590cc)
[task 2022-01-31T14:20:32.648Z] 14:20:32     INFO - GECKO(1588) |   Previous read of size 8 at 0x7b4000b4d158 by main thread:
[task 2022-01-31T14:20:32.649Z] 14:20:32     INFO - GECKO(1588) |     #0 <null> <null> (libxul.so+0x20093b8)
[task 2022-01-31T14:20:32.649Z] 14:20:32     INFO - GECKO(1588) |     #1 <null> <null> (libxul.so+0x200a7ca)
[task 2022-01-31T14:20:32.649Z] 14:20:32     INFO - GECKO(1588) |     #2 <null> <null> (libxul.so+0x200aba5)
[task 2022-01-31T14:20:32.649Z] 14:20:32     INFO - GECKO(1588) |     #3 <null> <null> (libxul.so+0xefeba7)
[task 2022-01-31T14:20:32.650Z] 14:20:32     INFO - GECKO(1588) |     #4 <null> <null> (libxul.so+0xf01d56)
[task 2022-01-31T14:20:32.650Z] 14:20:32     INFO - GECKO(1588) |     #5 <null> <null> (libxul.so+0xfa3aab)
[task 2022-01-31T14:20:32.650Z] 14:20:32     INFO - GECKO(1588) |     #6 <null> <null> (libxul.so+0xfa2bda)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #7 <null> <null> (libxul.so+0xfa9e22)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #8 <null> <null> (libxul.so+0x191d27d)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #9 <null> <null> (libxul.so+0x189b53c)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #10 <null> <null> (libxul.so+0x50d1316)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #11 <null> <null> (libxul.so+0x7020788)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #12 <null> <null> (libxul.so+0x7138fcb)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #13 <null> <null> (libxul.so+0x7139e39)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #14 <null> <null> (libxul.so+0x713a404)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #15 <null> <null> (libxul.so+0x7144d52)
[task 2022-01-31T14:20:32.651Z] 14:20:32     INFO - GECKO(1588) |     #16 <null> <null> (firefox+0xcf464)
[task 2022-01-31T14:20:32.652Z] 14:20:32     INFO - GECKO(1588) |     #17 <null> <null> (libc.so.6+0x21b96)
[task 2022-01-31T14:20:32.652Z] 14:20:32     INFO - GECKO(1588) |   Location is heap block of size 248 at 0x7b4000b4d100 allocated by thread T42:
[task 2022-01-31T14:20:32.652Z] 14:20:32     INFO - GECKO(1588) |     #0 <null> <null> (firefox+0x57add)
[task 2022-01-31T14:20:32.652Z] 14:20:32     INFO - GECKO(1588) |     #1 <null> <null> (firefox+0xd12bb)
[task 2022-01-31T14:20:32.652Z] 14:20:32     INFO - GECKO(1588) |     #2 <null> <null> (libxul.so+0x200a232)
[task 2022-01-31T14:20:32.653Z] 14:20:32     INFO - GECKO(1588) |     #3 <null> <null> (libxul.so+0x4ab89f7)
[task 2022-01-31T14:20:32.653Z] 14:20:32     INFO - GECKO(1588) |     #4 <null> <null> (libxul.so+0x4ab7b3d)
[task 2022-01-31T14:20:32.654Z] 14:20:32     INFO - GECKO(1588) |     #5 <null> <null> (libxul.so+0x4ab6edd)
[task 2022-01-31T14:20:32.654Z] 14:20:32     INFO - GECKO(1588) |     #6 <null> <null> (libxul.so+0x4ab61c1)
[task 2022-01-31T14:20:32.654Z] 14:20:32     INFO - GECKO(1588) |     #7 <null> <null> (libxul.so+0x4ab562e)
[task 2022-01-31T14:20:32.655Z] 14:20:32     INFO - GECKO(1588) |     #8 <null> <null> (libxul.so+0x4ab51fe)
[task 2022-01-31T14:20:32.655Z] 14:20:32     INFO - GECKO(1588) |     #9 <null> <null> (libxul.so+0xfa3403)
[task 2022-01-31T14:20:32.656Z] 14:20:32     INFO - GECKO(1588) |     #10 <null> <null> (libxul.so+0xfa9e22)
[task 2022-01-31T14:20:32.656Z] 14:20:32     INFO - GECKO(1588) |     #11 <null> <null> (libxul.so+0x4aafdfa)
[task 2022-01-31T14:20:32.656Z] 14:20:32     INFO - GECKO(1588) |     #12 <null> <null> (libxul.so+0xfa3403)
[task 2022-01-31T14:20:32.658Z] 14:20:32     INFO - GECKO(1588) |     #13 <null> <null> (libxul.so+0xfa9e22)
[task 2022-01-31T14:20:32.658Z] 14:20:32     INFO - GECKO(1588) |     #14 <null> <null> (libxul.so+0x191de1e)
[task 2022-01-31T14:20:32.658Z] 14:20:32     INFO - GECKO(1588) |     #15 <null> <null> (libxul.so+0x189b53c)
[task 2022-01-31T14:20:32.658Z] 14:20:32     INFO - GECKO(1588) |     #16 <null> <null> (libxul.so+0xf9f4e3)
[task 2022-01-31T14:20:32.659Z] 14:20:32     INFO - GECKO(1588) |     #17 <null> <null> (libnspr4.so+0x44fbd)
[task 2022-01-31T14:20:32.659Z] 14:20:32     INFO - GECKO(1588) |     #18 <null> <null> (firefox+0x590cc)
[task 2022-01-31T14:20:32.659Z] 14:20:32     INFO - GECKO(1588) |   Thread T42 'IndexedDB #13' (tid=2099, running) created by thread T7 at:
[task 2022-01-31T14:20:32.659Z] 14:20:32     INFO - GECKO(1588) |     #0 <null> <null> (firefox+0x5916d)
[task 2022-01-31T14:20:32.659Z] 14:20:32     INFO - GECKO(1588) |     #1 <null> <null> (libnspr4.so+0x3c1a5)
[task 2022-01-31T14:20:32.659Z] 14:20:32     INFO - GECKO(1588) |     #2 <null> <null> (libnspr4.so+0x30cf5)
[task 2022-01-31T14:20:32.660Z] 14:20:32     INFO - GECKO(1588) |     #3 <null> <null> (libxul.so+0xfa0b45)
[task 2022-01-31T14:20:32.660Z] 14:20:32     INFO - GECKO(1588) |     #4 <null> <null> (libxul.so+0xfa8f98)
[task 2022-01-31T14:20:32.661Z] 14:20:32     INFO - GECKO(1588) |     #5 <null> <null> (libxul.so+0xfb0d54)
[task 2022-01-31T14:20:32.661Z] 14:20:32     INFO - GECKO(1588) |     #6 <null> <null> (libxul.so+0xfabec6)
[task 2022-01-31T14:20:32.662Z] 14:20:32     INFO - GECKO(1588) |     #7 <null> <null> (libxul.so+0x4aaec3c)
[task 2022-01-31T14:20:32.662Z] 14:20:32     INFO - GECKO(1588) |     #8 <null> <null> (libxul.so+0x4ab44de)
[task 2022-01-31T14:20:32.662Z] 14:20:32     INFO - GECKO(1588) |     #9 <null> <null> (libxul.so+0x4a9f12f)
[task 2022-01-31T14:20:32.663Z] 14:20:32     INFO - GECKO(1588) |     #10 <null> <null> (libxul.so+0x1d3bd27)
[task 2022-01-31T14:20:32.663Z] 14:20:32     INFO - GECKO(1588) |     #11 <null> <null> (libxul.so+0x1e6ce61)
[task 2022-01-31T14:20:32.664Z] 14:20:32     INFO - GECKO(1588) |     #12 <null> <null> (libxul.so+0x19198bb)
[task 2022-01-31T14:20:32.664Z] 14:20:32     INFO - GECKO(1588) |     #13 <null> <null> (libxul.so+0x19183c7)
[task 2022-01-31T14:20:32.664Z] 14:20:32     INFO - GECKO(1588) |     #14 <null> <null> (libxul.so+0x19189f1)
[task 2022-01-31T14:20:32.665Z] 14:20:32     INFO - GECKO(1588) |     #15 <null> <null> (libxul.so+0x1918fc5)
[task 2022-01-31T14:20:32.665Z] 14:20:32     INFO - GECKO(1588) |     #16 <null> <null> (libxul.so+0xfa3403)
[task 2022-01-31T14:20:32.665Z] 14:20:32     INFO - GECKO(1588) |     #17 <null> <null> (libxul.so+0xfa9e22)
[task 2022-01-31T14:20:32.666Z] 14:20:32     INFO - GECKO(1588) |     #18 <null> <null> (libxul.so+0x191de88)
[task 2022-01-31T14:20:32.667Z] 14:20:32     INFO - GECKO(1588) |     #19 <null> <null> (libxul.so+0x189b53c)
[task 2022-01-31T14:20:32.667Z] 14:20:32     INFO - GECKO(1588) |     #20 <null> <null> (libxul.so+0xf9f4e3)
[task 2022-01-31T14:20:32.668Z] 14:20:32     INFO - GECKO(1588) |     #21 <null> <null> (libnspr4.so+0x44fbd)
[task 2022-01-31T14:20:32.668Z] 14:20:32     INFO - GECKO(1588) |     #22 <null> <null> (firefox+0x590cc)
[task 2022-01-31T14:20:32.668Z] 14:20:32     INFO - GECKO(1588) | SUMMARY: ThreadSanitizer: data race (/builds/worker/workspace/build/application/firefox/libmozsqlite3.so+0x3a262)
[task 2022-01-31T14:20:32.668Z] 14:20:32     INFO - GECKO(1588) | ==================
[task 2022-01-31T14:20:32.925Z] 14:20:32     INFO - GECKO(1588) | Exiting due to channel error.
[task 2022-01-31T14:20:32.925Z] 14:20:32     INFO - GECKO(1588) | Exiting due to channel error.
[task 2022-01-31T14:20:32.926Z] 14:20:32     INFO - GECKO(1588) | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=757.561) Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=758.441) [GFX1-]: Receive IPC close with reason=AbnormalShutdown
[task 2022-01-31T14:20:32.927Z] 14:20:32     INFO - GECKO(1588) | Exiting due to channel error.
[task 2022-01-31T14:20:32.927Z] 14:20:32     INFO - GECKO(1588) | Exiting due to channel error.
[task 2022-01-31T14:20:32.929Z] 14:20:32     INFO - GECKO(1588) | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=753.549) [GFX1-]: Receive IPC close with reason=AbnormalShutdown
[task 2022-01-31T14:20:32.929Z] 14:20:32     INFO - GECKO(1588) | Exiting due to channel error.
[task 2022-01-31T14:20:32.929Z] 14:20:32     INFO - GECKO(1588) | Exiting due to channel error.
[task 2022-01-31T14:20:34.004Z] 14:20:34     INFO - GECKO(1588) | Crash Annotation GraphicsCriticalError: |[C0][GFX1-]: Receive IPC close with reason=AbnormalShutdown (t=590.236)
[task 2022-01-31T14:20:34.005Z] 14:20:34     INFO - TEST-INFO | Main app process: killed by SIGIOT
[task 2022-01-31T14:20:34.006Z] 14:20:34     INFO - Buffered messages logged at 14:20:31

I'm going to move this over to IndexedDB because one of the threads involved with the race is an IDB thread. That said, given that the stack has failed to symbolize, this could be a race that we normally suppress.

Blocks: tsan
Group: firefox-core-security → dom-core-security
Component: Address Bar → Storage: IndexedDB
Product: Firefox → Core

I'm inclined to assume that either this is an already-suppressed race, or that there's not enough information to fix whatever race happened here, but somebody more familiar with this code and/or our TSan suppressions should probably take a look.

Status: NEW → RESOLVED
Closed: 3 years ago
Resolution: --- → INCOMPLETE
Group: dom-core-security
You need to log in before you can comment on or make changes to this bug.