1892868 - Perma [tier 2] org.mozilla.fenix.debug | java.lang.RuntimeException: StrictMode ThreadPolicy violation at org.mozilla.fenix.perf.ThreadPenaltyDeathWithIgnoresListener.penaltyDeath(ThreadPenaltyDeathWithIgnoresListener.kt:46)

Reporter

Description

•

11 months ago

treeherder

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

[task 2024-04-23T03:43:38.886Z] ???????????????????????????????????????????????????????????????????????????????????????????????????????????????????
[task 2024-04-23T03:43:38.886Z] ? OUTCOME ?      MATRIX ID       ? APP NAME ? TEST FILE NAME ?       TEST AXIS VALUE        ?    TEST DETAILS     ?
[task 2024-04-23T03:43:38.886Z] ???????????????????????????????????????????????????????????????????????????????????????????????????????????????????
[task 2024-04-23T03:43:38.886Z] ? success ? matrix-1kui6fo86oku4 ? app.apk  ? N/A            ? Pixel2.arm-27-en_US-portrait ? ---                 ?
[task 2024-04-23T03:43:38.886Z] ? failure ? matrix-1kui6fo86oku4 ? app.apk  ? N/A            ? java-30-en_US-portrait       ? 0 test cases failed ?
[task 2024-04-23T03:43:38.886Z] ? failure ? matrix-1kui6fo86oku4 ? app.apk  ? N/A            ? x1q-29-en_US-portrait        ? Application crashed ?
[task 2024-04-23T03:43:38.886Z] ? failure ? matrix-1kui6fo86oku4 ? app.apk  ? N/A            ? redfin-30-en_US-portrait     ? 0 test cases failed ?
[task 2024-04-23T03:43:38.886Z] ? failure ? matrix-1kui6fo86oku4 ? app.apk  ? N/A            ? oriole-31-en_US-portrait     ? 0 test cases failed ?
[task 2024-04-23T03:43:38.886Z] ???????????????????????????????????????????????????????????????????????????????????????????????????????????????????
[task 2024-04-23T03:43:38.886Z] More details are available at:
[task 2024-04-23T03:43:38.886Z] https://console.firebase.google.com/project/moz-fenix/testlab/histories/bh.66b7091e15d53d45/matrices/8656192483161899086
[task 2024-04-23T03:43:38.886Z] 
[task 2024-04-23T03:43:38.886Z] 
[task 2024-04-23T03:43:38.886Z] 
[task 2024-04-23T03:43:38.886Z] Matrices webLink
[task 2024-04-23T03:43:38.886Z]   matrix-1kui6fo86oku4 https://console.firebase.google.com/project/moz-fenix/testlab/histories/bh.66b7091e15d53d45/matrices/8656192483161899086
[task 2024-04-23T03:43:38.886Z] 
[task 2024-04-23T03:43:38.886Z] Command /usr/bin/java -jar /builds/worker/test-tools/flank.jar android run --config ./automation/taskcluster/androidTest/flank-arm-robo-test.yml --app /builds/worker/checkouts/gecko/mobile/android/fenix/app.apk --local-result-dir /builds/worker/artifacts/results --project moz-fenix --client-details matrixLabel=autoland failed with exit code 10
[task 2024-04-23T03:43:45.017Z] Failed to list files: CommandException: One or more URLs matched no objects.
[task 2024-04-23T03:43:45.017Z] 
[task 2024-04-23T03:43:45.017Z] No artifacts found for device: java-30-en_US-portrait
[task 2024-04-23T03:43:45.017Z] Copying gs://fenix_test_artifacts/2024-04-23_03-35-35.656041_pdYt/matrix_0/x1q-29-en_US-portrait/data_app_crash_0_org_mozilla_fenix_debug.txt to /builds/worker/artifacts/results
[task 2024-04-23T03:43:45.017Z] PROCESS-CRASH | org.mozilla.fenix.debug | java.lang.RuntimeException: StrictMode ThreadPolicy violation at org.mozilla.fenix.perf.ThreadPenaltyDeathWithIgnoresListener.penaltyDeath(ThreadPenaltyDeathWithIgnoresListener.kt:46)
[task 2024-04-23T03:43:45.017Z] 	at org.mozilla.fenix.perf.ThreadPenaltyDeathWithIgnoresListener.onThreadViolation(ThreadPenaltyDeathWithIgnoresListener.kt:40)
[task 2024-04-23T03:43:45.017Z] 	at android.os.StrictMode$AndroidBlockGuardPolicy.lambda$onThreadPolicyViolation$1(StrictMode.java:1782)
[task 2024-04-23T03:43:45.017Z] 	at android.os.-$$Lambda$StrictMode$AndroidBlockGuardPolicy$FxZGA9KtfTewqdcxlUwvIe5Nx9I.run(Unknown Source:4)
[task 2024-04-23T03:43:45.018Z] 	at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
[task 2024-04-23T03:43:45.018Z] 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
[task 2024-04-23T03:43:45.018Z] 	at java.lang.Thread.run(Thread.java:919)
[task 2024-04-23T03:43:45.018Z] Caused by: android.os.strictmode.DiskReadViolation
[task 2024-04-23T03:43:45.018Z] 	at android.os.StrictMode$AndroidBlockGuardPolicy.onReadFromDisk(StrictMode.java:1556)
[task 2024-04-23T03:43:45.018Z] 	at java.io.UnixFileSystem.getBooleanAttributes(UnixFileSystem.java:250)
[task 2024-04-23T03:43:45.018Z] 	at java.io.File.isDirectory(File.java:845)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.getAllRunningPackagePids(FreecessController.java:497)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.writeDevFile(FreecessController.java:537)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.sendFreecessSignal(FreecessController.java:673)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.sendFreecessSignal(FreecessController.java:665)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.unfreezePackageForOLAF(FreecessController.java:1677)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.unFreezeAction(FreecessController.java:1387)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.freecess.FreecessController.unFreezePackage(FreecessController.java:1247)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.BaseRestrictionMgr.isRestrictedPackage(BaseRestrictionMgr.java:668)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.am.BaseRestrictionMgr.isRestrictedPackage(BaseRestrictionMgr.java:293)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityStarter.startActivity(ActivityStarter.java:1223)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityStarter.startActivity(ActivityStarter.java:698)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityStarter.startActivityMayWait(ActivityStarter.java:1926)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityStarter.execute(ActivityStarter.java:629)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityTaskManagerService.startActivityAsUser(ActivityTaskManagerService.java:1706)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityTaskManagerService.startActivityAsUser(ActivityTaskManagerService.java:1602)
[task 2024-04-23T03:43:45.018Z] 	at com.android.server.wm.ActivityTaskManagerService.startActivity(ActivityTaskManagerService.java:1556)
[task 2024-04-23T03:43:45.018Z] 	at android.app.IActivityTaskManager$Stub.onTransact(IActivityTaskManager.java:1681)
[task 2024-04-23T03:43:45.018Z] 	at android.os.Binder.execTransactInternal(Binder.java:1021)
[task 2024-04-23T03:43:45.018Z] 	at android.os.Binder.execTransact(Binder.java:994)
[task 2024-04-23T03:43:45.018Z] 
[task 2024-04-23T03:43:45.018Z] Failed to list files: CommandException: One or more URLs matched no objects.
[task 2024-04-23T03:43:45.018Z] 
[task 2024-04-23T03:43:45.018Z] No artifacts found for device: redfin-30-en_US-portrait
[task 2024-04-23T03:43:45.018Z] Failed to list files: CommandException: One or more URLs matched no objects.
[task 2024-04-23T03:43:45.018Z] 
[task 2024-04-23T03:43:45.018Z] No artifacts found for device: oriole-31-en_US-portrait
[task 2024-04-23T03:43:45.018Z] Command ./automation/taskcluster/androidTest/copy-robo-crash-artifacts.py failed with exit code 1

Cosmin Sabou [:CosminS]

Updated

•

11 months ago

Severity: S4 → --

Priority: P5 → --

BugBot [:suhaib / :marco/ :calixte]

Comment 1

•

11 months ago

Set release status flags based on info from the regressing bug 1892811

:amejia, since you are the author of the regressor, bug 1892811, could you take a look? Also, could you set the severity field?

For more information, please visit BugBot documentation.

status-firefox125: --- → unaffected

status-firefox126: --- → unaffected

status-firefox127: --- → affected

Flags: needinfo?(amejiamarmol)

Aaron Train [:aaronmt]

Comment 2

•

11 months ago

Regression from https://bugzilla.mozilla.org/show_bug.cgi?id=1892811

Example matrix gets stuck on the browser select screen https://console.firebase.google.com/project/moz-fenix/testlab/histories/bh.66b7091e15d53d45/matrices/6576986711057520225/executions/bs.9235e2520e312de1/screenshots

Aaron Train [:aaronmt]

Comment 3

•

11 months ago

It's not clear to me if the browser choice select prompt is expected to be shown but I'm not sure why the crawler can't proceed

Arturo Mejia [:amejia]

Comment 4

•

11 months ago

It's not clear to me if the browser choice select prompt is expected to be shown.

Yeah, now it should be default experience.

but I'm not sure why the crawler can't proceed

Which tests triggers the crawler, maybe the best course of action for now it's disable the browser choice prompt in UI tests for now?

Flags: needinfo?(amejiamarmol) → needinfo?(aaron.train)

Aaron Train [:aaronmt]

Comment 5

•

11 months ago

•

Edited

re: Slack conversation.

Our regular UI tests are unaffected, the Robo tests which are less structured in launch parameters are affected

Example Matrix https://console.firebase.google.com/project/moz-fenix/testlab/histories/bh.66b7091e15d53d45/matrices/6105568387144740308

Robo Tests self-crawl: API 27/29/30/31
Pixel 2 (ARM) on API 27 was presented with a different default apps on launch screen, but the crawler was able to continue
Physical devices on 29/30/31 were presented with a system prompt on launch (browser choice) that the crawler was unable to click out of RequestRoleActivity

Remediation:

back-out of https://bugzilla.mozilla.org/show_bug.cgi?id=1892811
checking with Firebase Community on options for system prompt wether it's Robo Script or if their crawler can handle these dialogs

Flags: needinfo?(aaron.train)

Aaron Train [:aaronmt]

Comment 6

•

11 months ago

From Firebase Community

Hey Aaron, it looks like this dialog pops up right after the app is launched. As a result, Robo does not see the app-under-test being launched (hence, the logcat message you pasted above). Yeah, you can add a Roboscript that either dismisses this dialog by clicking "Cancel" or picks and saves a different preference.

Possible script

{
  "id": 1000,
  "crawlStage": "pre_crawl",
  "contextDescriptor": {
    "condition": "element_present",
    "elementDescriptors": [
      {
        "resourceId": "com.google.android.permissioncontroller:id/android:id/button2"
      }
    ]
  },
  "actions": [
    {
      "eventType": "VIEW_CLICKED",
      "elementDescriptors": [
        {
          "text": "Cancel"
        }
      ]
    }
  ]
}```

Arturo Mejia [:amejia]

Comment 7

•

11 months ago

Addressed on https://bugzilla.mozilla.org/show_bug.cgi?id=1892811#c12

Status: NEW → RESOLVED

Closed: 11 months ago

Resolution: --- → WONTFIX

Ryan VanderMeulen [:RyanVM]

Comment 8

•

11 months ago

This was fixed by backout.

status-firefox127: affected → fixed

Resolution: WONTFIX → FIXED

Target Milestone: --- → 127 Branch

Comment hidden (Intermittent Failures Robot)

Bugzilla

Perma [tier 2] org.mozilla.fenix.debug | java.lang.RuntimeException: StrictMode ThreadPolicy violation at org.mozilla.fenix.perf.ThreadPenaltyDeathWithIgnoresListener.penaltyDeath(ThreadPenaltyDeathWithIgnoresListener.kt:46)

Categories

(Fenix :: Onboarding, defect)

Tracking

(firefox125 unaffected, firefox126 unaffected, firefox127 fixed)

People

(Reporter: intermittent-bug-filer, Unassigned)

References

(Regression)

Details

(Keywords: intermittent-failure, regression)

Crash Data

Security

(public)

User Story

Description

Updated

Comment 1

Comment 2

Comment 3

Comment 4

Comment 5

Comment 6

Comment 7

Comment 8

Comment 9