Closed Bug 1726746 Opened 3 years ago Closed 3 years ago

Intermittent [tier 2] TEST-UNEXPECTED-TIMEOUT | browser/components/extensions/test/browser/browser_ext_pageAction_context.js | application timed out after 370 seconds with no output

Categories

(WebExtensions :: Untriaged, defect, P5)

Product:
WebExtensions
Component:
Untriaged
Type:
defect

Tracking

(Not tracked)

Status:
RESOLVED INCOMPLETE

People

(Reporter: intermittent-bug-filer, Unassigned)

Details

(Keywords: intermittent-failure)

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

[task 2021-08-20T09:04:57.759Z] 09:04:57     INFO - TEST-START | browser/components/extensions/test/browser/browser_ext_pageAction_context.js
[task 2021-08-20T09:11:09.635Z] 09:11:09     INFO - Buffered messages logged at 09:04:57
[task 2021-08-20T09:11:09.635Z] 09:11:09     INFO - Entering test bound testTabSwitchContext
[task 2021-08-20T09:11:09.636Z] 09:11:09     INFO - Extension loaded
[task 2021-08-20T09:11:09.637Z] 09:11:09     INFO - Console message: Warning: attempting to write 19337 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-08-20T09:11:09.637Z] 09:11:09     INFO - Console message: [JavaScript Warning: "Missing resource in locale es-ES: branding/brand.ftl"]
[task 2021-08-20T09:11:09.638Z] 09:11:09     INFO - Console message: [JavaScript Warning: "Missing resource in locale es-ES: branding/brand.ftl"]
[task 2021-08-20T09:11:09.638Z] 09:11:09     INFO - Console message: [JavaScript Warning: "Missing resource in locale es-ES: branding/brand.ftl"]
[task 2021-08-20T09:11:09.639Z] 09:11:09     INFO - Console message: Warning: attempting to write 19402 bytes to preference extensions.webextensions.uuids. This is bad for general performance and memory usage. Such an amount of data should rather be written to an external file. This preference will not be sent to any content processes.
[task 2021-08-20T09:11:09.639Z] 09:11:09     INFO - Console message: [JavaScript Warning: "browser.ui.customized_widgets - Keyed scalars cannot have more than 100 keys."]
[task 2021-08-20T09:11:09.640Z] 09:11:09     INFO - Initial state. No icon visible.
[task 2021-08-20T09:11:09.640Z] 09:11:09     INFO - Get details: tab={id: 298, url: about:blank}
[task 2021-08-20T09:11:09.640Z] 09:11:09     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_pageAction_context.js | expected value from isShown - Expected: false, Actual: false - 
[task 2021-08-20T09:11:09.641Z] 09:11:09     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_pageAction_context.js | image is disabled - 
[task 2021-08-20T09:11:09.641Z] 09:11:09     INFO - Show the icon on the first tab, expect default properties.
[task 2021-08-20T09:11:09.642Z] 09:11:09     INFO - Get details: tab={id: 298, url: about:blank}
<...>
[task 2021-08-20T09:11:09.770Z] 09:11:09     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_pageAction_context.js | image title is correct - 
[task 2021-08-20T09:11:09.771Z] 09:11:09     INFO - TEST-PASS | browser/components/extensions/test/browser/browser_ext_pageAction_context.js | image aria-label is correct - 
[task 2021-08-20T09:11:09.771Z] 09:11:09     INFO - Close the tab, go back to the 1st window.
[task 2021-08-20T09:11:09.771Z] 09:11:09     INFO - Buffered messages finished
[task 2021-08-20T09:11:09.772Z] 09:11:09    ERROR - TEST-UNEXPECTED-TIMEOUT | browser/components/extensions/test/browser/browser_ext_pageAction_context.js | application timed out after 370 seconds with no output
[task 2021-08-20T09:11:09.772Z] 09:11:09    ERROR - Force-terminating active process(es).
[task 2021-08-20T09:11:09.772Z] 09:11:09     INFO - Determining child pids from psutil...
[task 2021-08-20T09:11:09.772Z] 09:11:09     INFO - [2748, 2749, 2750, 2751, 2752, 2756, 2909, 2985, 2990, 3003]
[task 2021-08-20T09:11:09.772Z] 09:11:09     INFO - ==> process 2747 launched child process 2748
[task 2021-08-20T09:11:09.773Z] 09:11:09     INFO - ==> process 2747 launched child process 2749
[task 2021-08-20T09:11:09.773Z] 09:11:09     INFO - ==> process 2747 launched child process 2750
[task 2021-08-20T09:11:09.773Z] 09:11:09     INFO - ==> process 2747 launched child process 2751
<...>
[task 2021-08-20T09:11:09.816Z] 09:11:09     INFO - ==> process 2747 launched child process 2985
[task 2021-08-20T09:11:09.816Z] 09:11:09     INFO - ==> process 2747 launched child process 2990
[task 2021-08-20T09:11:09.816Z] 09:11:09     INFO - ==> process 2747 launched child process 3003
[task 2021-08-20T09:11:09.817Z] 09:11:09     INFO - Found child pids: {2748, 2749, 2750, 2751, 2752, 2753, 2754, 2755, 2756, 2761, 2762, 2767, 2768, 2810, 2811, 2812, 2813, 2814, 2815, 2816, 2817, 2818, 2823, 2824, 2825, 2826, 2827, 2828, 2829, 2830, 2831, 2832, 2833, 2834, 2835, 2836, 2837, 2842, 2843, 2854, 2855, 2860, 2861, 2862, 2863, 2864, 2865, 2866, 2867, 2868, 2869, 2870, 2871, 2876, 2877, 2878, 2879, 2880, 2881, 2882, 2883, 2884, 2885, 2886, 2887, 2888, 2889, 2890, 2891, 2896, 2897, 2898, 2899, 2900, 2905, 2906, 2907, 2908, 2909, 2914, 2915, 2916, 2917, 2918, 2919, 2920, 2921, 2922, 2923, 2924, 2925, 2926, 2931, 2932, 2933, 2934, 2935, 2936, 2937, 2938, 2939, 2940, 2941, 2948, 2949, 2950, 2951, 2952, 2953, 2958, 2959, 2960, 2961, 2962, 2963, 2964, 2965, 2966, 2967, 2968, 2969, 2974, 2975, 2976, 2977, 2978, 2979, 2980, 2981, 2982, 2983, 2984, 2985, 2990, 3003}
[task 2021-08-20T09:11:09.817Z] 09:11:09     INFO - Failed to get child procs
[task 2021-08-20T09:11:09.817Z] 09:11:09     INFO - Killing process: 2748
[task 2021-08-20T09:11:09.818Z] 09:11:09     INFO - TEST-INFO | started process screencapture
[task 2021-08-20T09:11:09.831Z] 09:11:09     INFO - TEST-INFO | screencapture: exit 0
[task 2021-08-20T09:11:09.831Z] 09:11:09     INFO - Killing process: 2749
[task 2021-08-20T09:11:09.832Z] 09:11:09     INFO - Not taking screenshot here: see the one that was previously logged
[task 2021-08-20T09:11:09.832Z] 09:11:09     INFO - Killing process: 2750
[task 2021-08-20T09:11:09.833Z] 09:11:09     INFO - Not taking screenshot here: see the one that was previously logged
<...>

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

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