Closed Bug 1505201 Opened 6 years ago Closed 6 years ago

Intermittent ==2470==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7f723785b7e8 bp 0x7f72335542c0 sp 0x7f72335542a0 T2) 0x7f723785fc87 in OnChannelError /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp:397:12

Categories

(Core :: IPC, defect, P5)

Product:
Core
Component:
IPC
Type:
defect

Tracking

()

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

Filed by: dvarga [at] mozilla.com https://treeherder.mozilla.org/logviewer.html#?job_id=210138233&repo=mozilla-inbound https://queue.taskcluster.net/v1/task/XYoeq8zHRUKvtYEXdLtlKQ/runs/0/artifacts/public/logs/live_backing.log [task 2018-11-06T18:18:17.942Z] 18:18:17 INFO - TEST-START | testing/marionette/harness/marionette_harness/tests/unit/test_timeouts.py TestTimeouts.test_reset_timeout [task 2018-11-06T18:18:17.943Z] 18:18:17 INFO - 1541528297934 Marionette TRACE 557 <- [1,10,null,{"value":null}] [task 2018-11-06T18:18:17.944Z] 18:18:17 INFO - 1541528297940 Marionette DEBUG Closed connection 557 [task 2018-11-06T18:18:17.946Z] 18:18:17 INFO - 1541528297944 Marionette DEBUG Accepted connection 558 from 127.0.0.1:46044 [task 2018-11-06T18:18:17.952Z] 18:18:17 INFO - 1541528297948 Marionette TRACE 558 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}] [task 2018-11-06T18:18:17.961Z] 18:18:17 INFO - 1541528297952 Marionette DEBUG [4294967339] Frame script loaded [task 2018-11-06T18:18:17.962Z] 18:18:17 INFO - 1541528297956 Marionette DEBUG [4294967339] Frame script registered [task 2018-11-06T18:18:17.963Z] 18:18:17 INFO - 1541528297957 Marionette DEBUG [10737418806] Frame script loaded [task 2018-11-06T18:18:17.965Z] 18:18:17 INFO - 1541528297958 Marionette DEBUG [10737418806] Frame script registered [task 2018-11-06T18:18:17.977Z] 18:18:17 INFO - 1541528297968 Marionette TRACE 558 <- [1,1,null,{"sessionId":"93cbfb70-b120-455b-b6c9-6e7142b7b78c","capabilities":{"browserName":"firefox","browserVersion":"65.0a ... p/tmpqSywkQ.mozrunner","moz:shutdownTimeout":180000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}] [task 2018-11-06T18:18:17.979Z] 18:18:17 INFO - 1541528297971 Marionette TRACE 558 -> [0,2,"WebDriver:SetTimeouts",{"script":30000}] [task 2018-11-06T18:18:17.981Z] 18:18:17 INFO - 1541528297972 Marionette TRACE 558 <- [1,2,null,{"value":null}] [task 2018-11-06T18:18:17.982Z] 18:18:17 INFO - 1541528297974 Marionette TRACE 558 -> [0,3,"WebDriver:SetTimeouts",{"pageLoad":300000}] [task 2018-11-06T18:18:17.984Z] 18:18:17 INFO - 1541528297975 Marionette TRACE 558 <- [1,3,null,{"value":null}] [task 2018-11-06T18:18:17.985Z] 18:18:17 INFO - 1541528297978 Marionette TRACE 558 -> [0,4,"WebDriver:SetTimeouts",{"implicit":0}] [task 2018-11-06T18:18:17.989Z] 18:18:17 INFO - 1541528297982 Marionette TRACE 558 <- [1,4,null,{"value":null}] [task 2018-11-06T18:18:17.991Z] 18:18:17 INFO - 1541528297988 Marionette TRACE 558 -> [0,5,"WebDriver:GetTimeouts",{}] [task 2018-11-06T18:18:17.993Z] 18:18:17 INFO - 1541528297990 Marionette TRACE 558 <- [1,5,null,{"implicit":0,"pageLoad":300000,"script":30000}] [task 2018-11-06T18:18:17.998Z] 18:18:17 INFO - 1541528297995 Marionette TRACE 558 -> [0,6,"WebDriver:GetTimeouts",{}] [task 2018-11-06T18:18:18.000Z] 18:18:18 INFO - 1541528297995 Marionette TRACE 558 <- [1,6,null,{"implicit":0,"pageLoad":300000,"script":30000}] [task 2018-11-06T18:18:18.002Z] 18:18:18 INFO - 1541528297997 Marionette TRACE 558 -> [0,7,"WebDriver:GetTimeouts",{}] [task 2018-11-06T18:18:18.003Z] 18:18:18 INFO - 1541528297999 Marionette TRACE 558 <- [1,7,null,{"implicit":0,"pageLoad":300000,"script":30000}] [task 2018-11-06T18:18:18.012Z] 18:18:18 INFO - 1541528298005 Marionette TRACE 558 -> [0,8,"Marionette:GetContext",{}] [task 2018-11-06T18:18:18.014Z] 18:18:18 INFO - 1541528298006 Marionette TRACE 558 <- [1,8,null,{"value":"content"}] [task 2018-11-06T18:18:18.044Z] 18:18:18 INFO - 1541528298007 Marionette TRACE 558 -> [0,9,"WebDriver:DeleteSession",{}] [task 2018-11-06T18:18:18.045Z] 18:18:18 INFO - 1541528298012 Marionette TRACE 558 <- [1,9,null,{"value":null}] [task 2018-11-06T18:18:18.256Z] 18:18:18 INFO - Application command: /builds/worker/workspace/build/application/firefox/firefox -no-remote -marionette -profile /tmp/tmpqSywkQ.mozrunner [task 2018-11-06T18:18:19.387Z] 18:18:19 INFO - 1541528299383 Marionette DEBUG Received observer notification profile-after-change [task 2018-11-06T18:18:19.504Z] 18:18:19 INFO - 1541528299492 Marionette DEBUG Received observer notification command-line-startup [task 2018-11-06T18:18:19.506Z] 18:18:19 INFO - 1541528299493 Marionette DEBUG Received observer notification nsPref:changed [task 2018-11-06T18:18:19.506Z] 18:18:19 INFO - 1541528299494 Marionette DEBUG Init aborted (running=false, enabled=true, finalUIStartup=false) [task 2018-11-06T18:18:21.469Z] 18:18:21 INFO - 1541528301467 Marionette DEBUG Received observer notification sessionstore-windows-restored [task 2018-11-06T18:18:21.473Z] 18:18:21 INFO - 1541528301471 Marionette DEBUG Waiting for delayed startup... [task 2018-11-06T18:18:24.174Z] 18:18:24 INFO - 1541528304170 Marionette DEBUG Waiting for startup tests... [task 2018-11-06T18:18:24.554Z] 18:18:24 INFO - 1541528304544 Marionette INFO Listening on port 2828 [task 2018-11-06T18:18:24.555Z] 18:18:24 INFO - 1541528304545 Marionette DEBUG Remote service is active [task 2018-11-06T18:18:24.635Z] 18:18:24 INFO - 1541528304631 Marionette DEBUG Accepted connection 0 from 127.0.0.1:46182 [task 2018-11-06T18:18:24.795Z] 18:18:24 INFO - 1541528304783 Marionette DEBUG Closed connection 0 [task 2018-11-06T18:18:24.796Z] 18:18:24 INFO - 1541528304786 Marionette DEBUG Accepted connection 1 from 127.0.0.1:46184 [task 2018-11-06T18:18:24.913Z] 18:18:24 INFO - 1541528304901 Marionette TRACE 1 -> [0,1,"WebDriver:NewSession",{"strictFileInteractability":true}] [task 2018-11-06T18:18:25.295Z] 18:18:25 INFO - 1541528305286 Marionette DEBUG [2147483649] Frame script loaded [task 2018-11-06T18:18:25.329Z] 18:18:25 INFO - 1541528305321 Marionette DEBUG [2147483649] Frame script registered [task 2018-11-06T18:18:25.399Z] 18:18:25 INFO - 1541528305393 Marionette TRACE 1 <- [1,1,null,{"sessionId":"1b929d29-8e45-4e5b-ad54-f5bb3c427499","capabilities":{"browserName":"firefox","browserVersion":"65.0a ... p/tmpqSywkQ.mozrunner","moz:shutdownTimeout":180000,"moz:useNonSpecCompliantPointerOrigin":false,"moz:webdriverClick":true}}] [task 2018-11-06T18:18:25.465Z] 18:18:25 INFO - 1541528305461 Marionette TRACE 1 -> [0,2,"Marionette:SetContext",{"value":"content"}] [task 2018-11-06T18:18:25.467Z] 18:18:25 INFO - 1541528305465 Marionette TRACE 1 <- [1,2,null,{"value":null}] [task 2018-11-06T18:18:25.652Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-11-06T18:18:25.653Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-11-06T18:18:25.654Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-11-06T18:18:25.656Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-11-06T18:18:25.657Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-11-06T18:18:25.658Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: pipe error: Broken pipe: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/ipc_channel_posix.cc, line 736 [task 2018-11-06T18:18:25.659Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: FileDescriptorSet destroyed with unconsumed descriptors: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/file_descriptor_set_posix.cc, line 22 [task 2018-11-06T18:18:25.660Z] 18:18:25 INFO - [Child 2470, Chrome_ChildThread] WARNING: FileDescriptorSet destroyed with unconsumed descriptors: file /builds/worker/workspace/build/src/ipc/chromium/src/chrome/common/file_descriptor_set_posix.cc, line 22 [task 2018-11-06T18:18:25.661Z] 18:18:25 INFO - AddressSanitizer:DEADLYSIGNAL [task 2018-11-06T18:18:25.662Z] 18:18:25 INFO - ================================================================= [task 2018-11-06T18:18:25.663Z] 18:18:25 ERROR - ==2470==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7f723785b7e8 bp 0x7f72335542c0 sp 0x7f72335542a0 T2) [task 2018-11-06T18:18:25.665Z] 18:18:25 INFO - ==2470==The signal is caused by a WRITE memory access. [task 2018-11-06T18:18:25.666Z] 18:18:25 INFO - ==2470==Hint: address points to the zero page. [task 2018-11-06T18:18:26.704Z] 18:18:26 INFO - #0 0x7f723785b7e7 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2669:13 [task 2018-11-06T18:18:26.706Z] 18:18:26 INFO - #1 0x7f723785fc87 in OnChannelError /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp:397:12 [task 2018-11-06T18:18:26.707Z] 18:18:26 INFO - #2 0x7f723785fc87 in non-virtual thunk to mozilla::ipc::ProcessLink::OnChannelError() /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp [task 2018-11-06T18:18:26.724Z] 18:18:26 INFO - #3 0x7f7237801de7 in event_persist_closure /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1580:9 [task 2018-11-06T18:18:26.724Z] 18:18:26 INFO - #4 0x7f7237801de7 in event_process_active_single_queue /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1639 [task 2018-11-06T18:18:26.724Z] 18:18:26 INFO - #5 0x7f72377f9c15 in event_process_active /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c [task 2018-11-06T18:18:26.725Z] 18:18:26 INFO - #6 0x7f72377f9c15 in event_base_loop /builds/worker/workspace/build/src/ipc/chromium/src/third_party/libevent/event.c:1961 [task 2018-11-06T18:18:26.742Z] 18:18:26 INFO - #7 0x7f72377b95b2 in base::MessagePumpLibevent::Run(base::MessagePump::Delegate*) /builds/worker/workspace/build/src/ipc/chromium/src/base/message_pump_libevent.cc:373:7 [task 2018-11-06T18:18:26.742Z] 18:18:26 INFO - #8 0x7f72377b3d2f in RunInternal /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:325:10 [task 2018-11-06T18:18:26.743Z] 18:18:26 INFO - #9 0x7f72377b3d2f in RunHandler /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:318 [task 2018-11-06T18:18:26.744Z] 18:18:26 INFO - #10 0x7f72377b3d2f in MessageLoop::Run() /builds/worker/workspace/build/src/ipc/chromium/src/base/message_loop.cc:298 [task 2018-11-06T18:18:26.744Z] 18:18:26 INFO - #11 0x7f72377cffdd in base::Thread::ThreadMain() /builds/worker/workspace/build/src/ipc/chromium/src/base/thread.cc:198:16 [task 2018-11-06T18:18:26.745Z] 18:18:26 INFO - #12 0x7f72377c4fdc in ThreadFunc(void*) /builds/worker/workspace/build/src/ipc/chromium/src/base/platform_thread_posix.cc:40:13 [task 2018-11-06T18:18:26.745Z] 18:18:26 INFO - #13 0x7f72567f26b9 in start_thread (/lib/x86_64-linux-gnu/libpthread.so.0+0x76b9) [task 2018-11-06T18:18:26.806Z] 18:18:26 INFO - #14 0x7f725587b41c in clone /build/glibc-Cl5G7W/glibc-2.23/misc/../sysdeps/unix/sysv/linux/x86_64/clone.S:109 [task 2018-11-06T18:18:26.807Z] 18:18:26 INFO - AddressSanitizer can not provide additional info. [task 2018-11-06T18:18:26.808Z] 18:18:26 INFO - SUMMARY: AddressSanitizer: SEGV /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2669:13 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink()
It cannot be a Marionette bug when it actually fails in Firefox.
Component: Marionette → IPC
Product: Testing → Core
Summary: Intermittent ==2470==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7f723785b7e8 bp 0x7f72335542c0 sp 0x7f72335542a0 T2) → Intermittent ==2470==ERROR: AddressSanitizer: SEGV on unknown address 0x000000000001 (pc 0x7f723785b7e8 bp 0x7f72335542c0 sp 0x7f72335542a0 T2) 0x7f723785fc87 in OnChannelError /builds/worker/workspace/build/src/ipc/glue/MessageLink.cpp:397:12
Version: Version 3 → unspecified
> #0 0x7f723785b7e7 in mozilla::ipc::MessageChannel::OnChannelErrorFromLink() /builds/worker/workspace/build/src/ipc/glue/MessageChannel.cpp:2669:13 This is MOZ_CRASH("Aborting on channel error."), assuming the location is accurate. https://searchfox.org/mozilla-central/rev/6e0e603f4852b8e571e5b8ae133e772b18b6016e/ipc/glue/MessageChannel.cpp#2669

https://wiki.mozilla.org/Bug_Triage#Intermittent_Test_Failure_Cleanup

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