1596072 - Intermittent org.mozilla.geckoview.test.AutofillDelegateTest#autofillActiveChange | application crashed [@ mozilla::net::nsSocketTransport::InitiateSocket()]

Status: RESOLVED DUPLICATE of bug 1564920

(GeckoView :: General, defect)

Description

[Treeherder Bug Filer]

Filed by: nbeleuzu [at] mozilla.com
Parsed log: https://treeherder.mozilla.org/logviewer.html#?job_id=275992925&repo=autoland
Full log: https://firefox-ci-tc.services.mozilla.com/api/queue/v1/task/TG2Gzf_iQL6weqxnOMtTDg/runs/0/artifacts/public/logs/live_backing.log

---

[task 2019-11-13T11:46:53.112Z] 11:46:53 INFO - TEST-START | org.mozilla.geckoview.test.AutofillDelegateTest.autofillActiveChange
[task 2019-11-13T11:46:54.617Z] 11:46:54 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_RESULT: shortMsg=Process crashed.
[task 2019-11-13T11:46:54.617Z] 11:46:54 INFO - org.mozilla.geckoview.test | INSTRUMENTATION_CODE: 0
[task 2019-11-13T11:46:54.617Z] 11:46:54 INFO - Passed: 0
[task 2019-11-13T11:46:54.617Z] 11:46:54 INFO - Failed: 0
[task 2019-11-13T11:46:54.617Z] 11:46:54 INFO - Todo: 0
[task 2019-11-13T11:46:54.617Z] 11:46:54 INFO - SUITE-END | took 3s
[task 2019-11-13T11:46:55.247Z] 11:46:55 INFO - mozcrash Copy/paste: /builds/worker/workspace/build/linux64-minidump_stackwalk /tmp/tmpSXEsxU/01c7a617-0702-87bc-ccaa-dc058f1ebc54.dmp /builds/worker/workspace/build/symbols
[task 2019-11-13T11:47:00.029Z] 11:47:00 INFO - mozcrash Saved minidump as /builds/worker/workspace/build/blobber_upload_dir/01c7a617-0702-87bc-ccaa-dc058f1ebc54.dmp
[task 2019-11-13T11:47:00.029Z] 11:47:00 INFO - mozcrash Saved app info as /builds/worker/workspace/build/blobber_upload_dir/01c7a617-0702-87bc-ccaa-dc058f1ebc54.extra
[task 2019-11-13T11:47:00.038Z] 11:47:00 WARNING - PROCESS-CRASH | org.mozilla.geckoview.test.AutofillDelegateTest.autofillActiveChange | application crashed [@ mozilla::net::nsSocketTransport::InitiateSocket()]
[task 2019-11-13T11:47:00.038Z] 11:47:00 INFO - Crash dump filename: /tmp/tmpSXEsxU/01c7a617-0702-87bc-ccaa-dc058f1ebc54.dmp
[task 2019-11-13T11:47:00.038Z] 11:47:00 INFO - Operating system: Android
[task 2019-11-13T11:47:00.038Z] 11:47:00 INFO - 0.0.0 Linux 3.10.0+ #260 SMP PREEMPT Fri May 19 12:48:14 PDT 2017 x86_64
[task 2019-11-13T11:47:00.038Z] 11:47:00 INFO - CPU: amd64
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - family 6 model 6 stepping 3
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - 4 CPUs
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - GPU: UNKNOWN
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Crash reason: SIGSEGV /SEGV_MAPERR
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Crash address: 0x0
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Process uptime: not available
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Thread 30 (crashed)
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - 0 libxul.so!mozilla::net::nsSocketTransport::InitiateSocket() [nsSocketTransport2.cpp:360c8b9f1566c66e8890f8bda2891a508ad36cc9 : 1339 + 0x29]
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rax = 0x000078a2d6bfc3ac rdx = 0x0000000000000004
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rcx = 0x000078a2da952a80 rbx = 0x000078a2c8295ca0
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rsi = 0x000078a2cbff0bc0 rdi = 0x000000000000001b
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rbp = 0x000078a2cbff15e0 rsp = 0x000078a2cbff1270
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - r8 = 0x0000000000000000 r9 = 0x000078a2f8ee4090
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - r10 = 0x0000000000000018 r11 = 0x0000000000000246
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - r12 = 0x000078a2cbff14c0 r13 = 0x000078a2da380800
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - r14 = 0x000078a2da380920 r15 = 0x000078a2cbff13d0
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rip = 0x000078a2d18d1f99
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Found by: given as instruction pointer in context
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - 1 libxul.so!mozilla::net::nsSocketTransport::OnSocketEvent(unsigned int, nsresult, nsISupports*) [nsSocketTransport2.cpp:360c8b9f1566c66e8890f8bda2891a508ad36cc9 : 0 + 0x8]
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rbp = 0x000078a2cbff1620 rsp = 0x000078a2cbff15f0
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rip = 0x000078a2d18d34f6
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Found by: previous frame's frame pointer
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - 2 libxul.so!mozilla::net::nsSocketEvent::Run() [nsSocketTransport2.cpp:360c8b9f1566c66e8890f8bda2891a508ad36cc9 : 93 + 0x1b]
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rbp = 0x000078a2cbff1640 rsp = 0x000078a2cbff1630
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rip = 0x000078a2d18ea426
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Found by: previous frame's frame pointer
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - 3 libxul.so!nsThread::ProcessNextEvent(bool, bool*) [nsThread.cpp:360c8b9f1566c66e8890f8bda2891a508ad36cc9 : 1250 + 0x11]
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rbp = 0x000078a2cbff1bb0 rsp = 0x000078a2cbff1650
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rip = 0x000078a2d17b6597
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - Found by: previous frame's frame pointer
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - 4 libxul.so!NS_ProcessNextEvent(nsIThread*, bool) [nsThreadUtils.cpp:360c8b9f1566c66e8890f8bda2891a508ad36cc9 : 486 + 0x10]
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rbp = 0x000078a2cbff1bf0 rsp = 0x000078a2cbff1bc0
[task 2019-11-13T11:47:00.048Z] 11:47:00 INFO - rip = 0x000078a2d17b9647

Comment 1

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6

Platform breakdown:

• android-em-7-0-x86_64: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1596072&startday=2019-11-11&endday=2019-11-17&tree=all

Comment 2

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 4
• mozilla-central: 1

Platform breakdown:

• android-em-7-0-x86_64: 5

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1596072&startday=2019-11-18&endday=2019-11-24&tree=all

Comment 3

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6

Platform breakdown:

• android-em-7-0-x86_64: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1596072&startday=2019-11-25&endday=2019-12-01&tree=all

Comment 4

[Intermittent Failures Robot]

12 failures in 5144 pushes (0.002 failures/push) were associated with this bug in the last 7 days.

Repository breakdown:

• autoland: 11
• mozilla-beta: 1

Platform breakdown:

• android-em-7-0-x86_64: 12

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1596072&startday=2019-12-02&endday=2019-12-08&tree=all

Comment 5

[Geoff Brown [:gbrown]]

autofillActiveChange is a geckoview-junit test; it has no relation to raptor.

Comment 6

[Geoff Brown [:gbrown]]

As in https://bugzilla.mozilla.org/show_bug.cgi?id=1564920#c28, this is an attempt to access shavar.services.mozilla.com.

That's unexpected because test prefs are set to override that hostname:

https://searchfox.org/mozilla-central/rev/23d4bffcad365e68d2d45776017056b76ca9a968/testing/profiles/unittest-required/user.js#42

and logcat shows that the test profile has been requested:

https://firefoxci.taskcluster-artifacts.net/Jf9_JfoQS5qF-oNluE1d9g/0/public/test_info//logcat-emulator-5554.log

12-10 14:28:11.977  2773  2798 D GeckoProfile: Loading profile at: /sdcard/tests/junit-profile name: 
...
12-10 14:28:12.273  2773  2798 D GeckoThread: State changed to PROFILE_READY
12-10 14:28:12.288  2773  2798 D GeckoViewStartup: observe: profile-after-change
...
12-10 14:28:12.605  2773  2805 I Gecko   : FATAL ERROR: Non-local network connections are disabled and a connection attempt to shavar.services.mozilla.com (52.33.139.34) was made.
12-10 14:28:12.605  2773  2805 I Gecko   : You should only access hostnames available via the test networking proxy (if running mochitests) or from a test-specific httpd.js server (if running xpcshell tests). Browser services should be disabled or redirected to a local server.
12-10 14:28:12.605  2773  2805 F MOZ_CRASH: Hit MOZ_CRASH(Attempting to connect to non-local address!) at /builds/worker/workspace/build/src/netwerk/base/nsSocketTransport2.cpp:1339

Comment 7

[Geoff Brown [:gbrown]]

In https://treeherder.mozilla.org/#/jobs?repo=try&revision=982cd2abf3bfa322ffe734c432d4c2cc21e6b5ed, I grep'd the remote profile directory for the relevant prefs: they seem to be set just as I would expect.

[task 2019-12-10T20:32:55.895Z] 20:32:55     INFO -  /sdcard/tests/junit-profile/user.js:user_pref("browser.safebrowsing.provider.mozilla.gethashURL", "http://10.0.2.2:8888/safebrowsing-dummy/gethash");
[task 2019-12-10T20:32:55.895Z] 20:32:55     INFO -  /sdcard/tests/junit-profile/user.js:user_pref("browser.safebrowsing.provider.mozilla.updateURL", "http://10.0.2.2:8888/safebrowsing-dummy/update");

Comment 8

[Geoff Brown [:gbrown]]

I was able to reproduce this failure with the extra logging:

https://treeherder.mozilla.org/logviewer.html#?job_id=280577571&repo=try

[task 2019-12-11T00:09:08.853Z] 00:09:08     INFO -  /sdcard/tests/junit-profile/junit-profile/user.js:user_pref("browser.safebrowsing.provider.mozilla.gethashURL", "http://10.0.2.2:8888/safebrowsing-dummy/gethash");
[task 2019-12-11T00:09:08.854Z] 00:09:08     INFO -  /sdcard/tests/junit-profile/junit-profile/user.js:user_pref("browser.safebrowsing.provider.mozilla.updateURL", "http://10.0.2.2:8888/safebrowsing-dummy/update");

The content is correct but the file location is wrong!

Comment 9

[Geoff Brown [:gbrown]]

This is the same failure as bug 1564920 and there is more history there, so...

Comment 10

[Intermittent Failures Robot]

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

Repository breakdown:

• autoland: 6

Platform breakdown:

• android-em-7-0-x86_64: 6

For more details, see:
https://treeherder.mozilla.org/intermittent-failures.html#/bugdetails?bug=1596072&startday=2019-12-09&endday=2019-12-15&tree=all

Comment 11

[[ex-Mozilla] Agi Sferro | :agi]

6c6f5da9-bf33-4082-a19d-7d99e8083d97 Mass rename intermittents due to Bug 1723034.